builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1473257206.74 results: success (0) buildid: 20160907004009 builduid: 4e2b6e876f594fbe91551200ebdb17c0 revision: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:46.736353) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:46.736893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:46.737244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:46.755417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:46.755750) ========= 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=5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-07 07:06:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.7M=0.001s 2016-09-07 07:06:47 (13.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.373134 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:47.176659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:47.177027) ========= 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=5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017944 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:47.210724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:47.214169) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a0fd1bb116a3b79b6f33462a04144818b550ee9 --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 3a0fd1bb116a3b79b6f33462a04144818b550ee9 --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=5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-07 07:06:47,293 truncating revision to first 12 chars 2016-09-07 07:06:47,294 Setting DEBUG logging. 2016-09-07 07:06:47,294 attempt 1/10 2016-09-07 07:06:47,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a0fd1bb116a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 07:06:47,869 unpacking tar archive at: mozilla-aurora-3a0fd1bb116a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:48.119310) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:48.119689) ========= script_repo_revision: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:48.120163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:48.120478) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 07:06:48.131569) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-07 07:06:48.131931) ========= /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=5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:48 INFO - MultiFileLogger online at 20160907 07:06:48 in /builds/slave/test 07:06:48 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 07:06:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:48 INFO - {'append_to_log': False, 07:06:48 INFO - 'base_work_dir': '/builds/slave/test', 07:06:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:06:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:48 INFO - 'branch': 'Mozilla-Aurora', 07:06:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:48 INFO - 'config_files': ('talos/linux_config.py',), 07:06:48 INFO - 'default_actions': ('clobber', 07:06:48 INFO - 'read-buildbot-config', 07:06:48 INFO - 'download-and-extract', 07:06:48 INFO - 'populate-webroot', 07:06:48 INFO - 'create-virtualenv', 07:06:48 INFO - 'install', 07:06:48 INFO - 'run-tests'), 07:06:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:48 INFO - 'download_minidump_stackwalk': True, 07:06:48 INFO - 'download_symbols': 'ondemand', 07:06:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:48 INFO - 'installer_path': 'installer.exe', 07:06:48 INFO - 'log_level': 'info', 07:06:48 INFO - 'log_name': 'talos', 07:06:48 INFO - 'log_to_console': True, 07:06:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:48 INFO - 'opt_config_files': (), 07:06:48 INFO - 'pip_index': False, 07:06:48 INFO - 'sps_profile': False, 07:06:48 INFO - 'sps_profile_interval': 0, 07:06:48 INFO - 'suite': 'dromaeojs-e10s', 07:06:48 INFO - 'system_bits': '32', 07:06:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:48 INFO - 'title': 'talos-linux64-ix-039', 07:06:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:48 INFO - 'use_talos_json': True, 07:06:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:48 INFO - 'work_dir': 'build'} 07:06:48 INFO - [mozharness: 2016-09-07 14:06:48.303884Z] Running clobber step. 07:06:48 INFO - Running pre-action listener: _resource_record_pre_action 07:06:48 INFO - Running main action method: clobber 07:06:48 INFO - rmtree: /builds/slave/test/build 07:06:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:48 INFO - Running post-action listener: _resource_record_post_action 07:06:48 INFO - [mozharness: 2016-09-07 14:06:48.740938Z] Finished clobber step (success) 07:06:48 INFO - [mozharness: 2016-09-07 14:06:48.741039Z] Running read-buildbot-config step. 07:06:48 INFO - Running pre-action listener: _resource_record_pre_action 07:06:48 INFO - Running main action method: read_buildbot_config 07:06:48 INFO - Using buildbot properties: 07:06:48 INFO - { 07:06:48 INFO - "project": "", 07:06:48 INFO - "product": "firefox", 07:06:48 INFO - "script_repo_revision": "production", 07:06:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:06:48 INFO - "repository": "", 07:06:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:06:48 INFO - "buildid": "20160907004009", 07:06:48 INFO - "stage_platform": "linux64-pgo", 07:06:48 INFO - "basedir": "/builds/slave/test", 07:06:48 INFO - "nightly_build": "True", 07:06:48 INFO - "buildnumber": 489, 07:06:48 INFO - "slavename": "talos-linux64-ix-039", 07:06:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:06:48 INFO - "platform": "ubuntu64_hw", 07:06:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:06:48 INFO - "branch": "mozilla-aurora", 07:06:48 INFO - "repo_path": "releases/mozilla-aurora", 07:06:48 INFO - "revision": "3a0fd1bb116a3b79b6f33462a04144818b550ee9", 07:06:48 INFO - "pgo_build": "True", 07:06:48 INFO - "builduid": "4e2b6e876f594fbe91551200ebdb17c0", 07:06:48 INFO - "slavebuilddir": "test" 07:06:48 INFO - } 07:06:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 07:06:48 INFO - Running post-action listener: _resource_record_post_action 07:06:48 INFO - [mozharness: 2016-09-07 14:06:48.743567Z] Finished read-buildbot-config step (success) 07:06:48 INFO - [mozharness: 2016-09-07 14:06:48.743657Z] Running download-and-extract step. 07:06:48 INFO - Running pre-action listener: _resource_record_pre_action 07:06:48 INFO - Running main action method: download_and_extract 07:06:48 INFO - mkdir: /builds/slave/test/build/tests 07:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:48 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:06:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:06:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:06:48 INFO - retry: Failed, sleeping 30 seconds before retrying 07:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:07:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:07:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:07:18 INFO - retry: Failed, sleeping 60 seconds before retrying 07:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:08:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:08:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:08:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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! 07:08:18 INFO - Caught exception: HTTP Error 404: Not Found 07:08:18 INFO - Caught exception: HTTP Error 404: Not Found 07:08:18 INFO - Caught exception: HTTP Error 404: Not Found 07:08:18 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:08:18 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:08:19 INFO - Downloaded 1361 bytes. 07:08:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 07:08:19 INFO - Using the following test package requirements: 07:08:19 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:08:19 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:19 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:08:19 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'jsshell-linux-x86_64.zip'], 07:08:19 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:19 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 07:08:19 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:08:19 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:08:19 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:19 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 07:08:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:19 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:19 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:08:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:08:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:08:19 INFO - retry: Failed, sleeping 30 seconds before retrying 07:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:08:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:08:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:08:49 INFO - retry: Failed, sleeping 60 seconds before retrying 07:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:09:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:09:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:09:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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! 07:09:49 INFO - Caught exception: HTTP Error 404: Not Found 07:09:49 INFO - Caught exception: HTTP Error 404: Not Found 07:09:49 INFO - Caught exception: HTTP Error 404: Not Found 07:09:49 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:09:49 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:09:50 INFO - Downloaded 21768581 bytes. 07:09:50 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'] 07:09:50 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 07:09:51 INFO - Return code: 0 07:09:51 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:51 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:09:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:09:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:09:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:09:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:09:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:09:51 INFO - retry: Failed, sleeping 30 seconds before retrying 07:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:10:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:10:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:10:21 INFO - retry: Failed, sleeping 60 seconds before retrying 07:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:11:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:11:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:11:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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! 07:11:21 INFO - Caught exception: HTTP Error 404: Not Found 07:11:21 INFO - Caught exception: HTTP Error 404: Not Found 07:11:21 INFO - Caught exception: HTTP Error 404: Not Found 07:11:21 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 07:11:21 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:11:22 INFO - Downloaded 21768581 bytes. 07:11:22 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'] 07:11:22 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 07:11:23 INFO - Return code: 0 07:11: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')]} 07:11:23 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:11:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:11:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:11:23 INFO - retry: Failed, sleeping 30 seconds before retrying 07:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:11:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:11:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:11:53 INFO - retry: Failed, sleeping 60 seconds before retrying 07:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:12:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:12:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:12:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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! 07:12:53 INFO - Caught exception: HTTP Error 404: Not Found 07:12:53 INFO - Caught exception: HTTP Error 404: Not Found 07:12:53 INFO - Caught exception: HTTP Error 404: Not Found 07:12:53 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 07:12:53 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:12:54 INFO - Downloaded 14413740 bytes. 07:12:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:12:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:12:54 INFO - Return code: 0 07:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:54 INFO - https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:12:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:12:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:12:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:12:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:12:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:12:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 07:12:54 INFO - retry: Failed, sleeping 30 seconds before retrying 07:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:13:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:13:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 07:13:25 INFO - retry: Failed, sleeping 60 seconds before retrying 07:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:14:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:14:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 07:14:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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! 07:14:25 INFO - Caught exception: HTTP Error 404: Not Found 07:14:25 INFO - Caught exception: HTTP Error 404: Not Found 07:14:25 INFO - Caught exception: HTTP Error 404: Not Found 07:14:25 INFO - trying https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:14:25 INFO - Downloading https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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 07:14:26 INFO - Downloaded 63871392 bytes. 07:14:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:14:26 INFO - mkdir: /builds/slave/test/properties 07:14:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:26 INFO - Contents: 07:14:26 INFO - build_url:https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 07:14:27 INFO - Running post-action listener: _resource_record_post_action 07:14:27 INFO - Running post-action listener: set_extra_try_arguments 07:14:27 INFO - [mozharness: 2016-09-07 14:14:27.001255Z] Finished download-and-extract step (success) 07:14:27 INFO - [mozharness: 2016-09-07 14:14:27.001487Z] Running populate-webroot step. 07:14:27 INFO - Running pre-action listener: _resource_record_pre_action 07:14:27 INFO - Running main action method: populate_webroot 07:14:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:27 INFO - '--tppagecycles', 07:14:27 INFO - '7'], 07:14:27 INFO - 'tests': ['tsvgm']}}, 07:14:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:14:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:14:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['damp', 'tps']}, 07:14:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'tests': ['damp', 'tps']}, 07:14:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['dromaeo_dom']}, 07:14:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['basic_compositor_video']}, 07:14:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:14:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['a11yr', 07:14:27 INFO - 'ts_paint', 07:14:27 INFO - 'tpaint', 07:14:27 INFO - 'sessionrestore', 07:14:27 INFO - 'sessionrestore_no_auto_restore', 07:14:27 INFO - 'tabpaint']}, 07:14:27 INFO - 'other-e10s': {'tests': ['a11yr', 07:14:27 INFO - 'ts_paint', 07:14:27 INFO - 'tpaint', 07:14:27 INFO - 'sessionrestore', 07:14:27 INFO - 'sessionrestore_no_auto_restore', 07:14:27 INFO - 'tabpaint']}, 07:14:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:14:27 INFO - 'ts_paint', 07:14:27 INFO - 'tpaint', 07:14:27 INFO - 'sessionrestore', 07:14:27 INFO - 'sessionrestore_no_auto_restore', 07:14:27 INFO - 'tabpaint']}, 07:14:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:14:27 INFO - 'ts_paint', 07:14:27 INFO - 'tpaint', 07:14:27 INFO - 'sessionrestore', 07:14:27 INFO - 'sessionrestore_no_auto_restore', 07:14:27 INFO - 'tabpaint']}, 07:14:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['a11yr', 07:14:27 INFO - 'ts_paint', 07:14:27 INFO - 'tpaint', 07:14:27 INFO - 'sessionrestore', 07:14:27 INFO - 'sessionrestore_no_auto_restore', 07:14:27 INFO - 'tabpaint']}, 07:14:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['a11yr', 07:14:27 INFO - 'ts_paint', 07:14:27 INFO - 'tpaint', 07:14:27 INFO - 'sessionrestore', 07:14:27 INFO - 'sessionrestore_no_auto_restore', 07:14:27 INFO - 'tabpaint']}, 07:14:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['tsvgx', 07:14:27 INFO - 'tsvgr_opacity', 07:14:27 INFO - 'tart', 07:14:27 INFO - 'tscrollx', 07:14:27 INFO - 'cart']}, 07:14:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:14:27 INFO - 'tsvgr_opacity', 07:14:27 INFO - 'tart', 07:14:27 INFO - 'tscrollx', 07:14:27 INFO - 'cart']}, 07:14:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'talos_options': ['--disable-e10s'], 07:14:27 INFO - 'tests': ['tp5o']}, 07:14:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'tests': ['tp5o']}, 07:14:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'talos_options': ['--disable-e10s', 07:14:27 INFO - '--xperf_path', 07:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:27 INFO - 'tests': ['tp5n']}, 07:14:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:27 INFO - 'talos_options': ['--xperf_path', 07:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:27 INFO - 'tests': ['tp5n']}}, 07:14:27 INFO - 'talos.zip': {'path': '', 07:14:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:27 INFO - Running post-action listener: _resource_record_post_action 07:14:27 INFO - [mozharness: 2016-09-07 14:14:27.023219Z] Finished populate-webroot step (success) 07:14:27 INFO - [mozharness: 2016-09-07 14:14:27.023309Z] Running create-virtualenv step. 07:14:27 INFO - Running pre-action listener: _resource_record_pre_action 07:14:27 INFO - Running main action method: create_virtualenv 07:14:27 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:27 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 07:14:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:27 INFO - Using real prefix '/usr' 07:14:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:29 INFO - Installing pip.................done. 07:14:29 INFO - Return code: 0 07:14:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:14:29 INFO - Using env: {'DISPLAY': ':0', 07:14:29 INFO - 'HOME': '/home/cltbld', 07:14:29 INFO - 'LANG': 'en_US.UTF-8', 07:14:29 INFO - 'LANGUAGE': 'en_US:en', 07:14:29 INFO - 'LOGNAME': 'cltbld', 07:14:29 INFO - 'MAIL': '/var/mail/cltbld', 07:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:29 INFO - 'MOZ_NO_REMOTE': '1', 07:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:29 INFO - 'NO_EM_RESTART': '1', 07:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:29 INFO - 'PWD': '/builds/slave/test', 07:14:29 INFO - 'SHELL': '/bin/bash', 07:14:29 INFO - 'SHLVL': '1', 07:14:29 INFO - 'TERM': 'linux', 07:14:29 INFO - 'TMOUT': '86400', 07:14:29 INFO - 'USER': 'cltbld', 07:14:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:29 INFO - '_': '/tools/buildbot/bin/python'} 07:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:14:29 INFO - Cleaning up... 07:14:29 INFO - Return code: 0 07:14:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:14:29 INFO - Using env: {'DISPLAY': ':0', 07:14:29 INFO - 'HOME': '/home/cltbld', 07:14:29 INFO - 'LANG': 'en_US.UTF-8', 07:14:29 INFO - 'LANGUAGE': 'en_US:en', 07:14:29 INFO - 'LOGNAME': 'cltbld', 07:14:29 INFO - 'MAIL': '/var/mail/cltbld', 07:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:29 INFO - 'MOZ_NO_REMOTE': '1', 07:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:29 INFO - 'NO_EM_RESTART': '1', 07:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:29 INFO - 'PWD': '/builds/slave/test', 07:14:29 INFO - 'SHELL': '/bin/bash', 07:14:29 INFO - 'SHLVL': '1', 07:14:29 INFO - 'TERM': 'linux', 07:14:29 INFO - 'TMOUT': '86400', 07:14:29 INFO - 'USER': 'cltbld', 07:14:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:29 INFO - '_': '/tools/buildbot/bin/python'} 07:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:30 INFO - Downloading/unpacking psutil>=3.1.1 07:14:30 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 07:14:30 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 07:14:30 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 07:14:30 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 07:14:30 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 07:14:30 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 07:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:31 INFO - Installing collected packages: psutil 07:14:31 INFO - Running setup.py install for psutil 07:14:32 INFO - building 'psutil._psutil_linux' extension 07:14:32 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 07:14:32 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 07:14:32 INFO - building 'psutil._psutil_posix' extension 07:14:32 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 07:14:32 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 07:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:32 INFO - Successfully installed psutil 07:14:32 INFO - Cleaning up... 07:14:32 INFO - Return code: 0 07:14:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:14:32 INFO - Using env: {'DISPLAY': ':0', 07:14:32 INFO - 'HOME': '/home/cltbld', 07:14:32 INFO - 'LANG': 'en_US.UTF-8', 07:14:32 INFO - 'LANGUAGE': 'en_US:en', 07:14:32 INFO - 'LOGNAME': 'cltbld', 07:14:32 INFO - 'MAIL': '/var/mail/cltbld', 07:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:32 INFO - 'MOZ_NO_REMOTE': '1', 07:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:32 INFO - 'NO_EM_RESTART': '1', 07:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:32 INFO - 'PWD': '/builds/slave/test', 07:14:32 INFO - 'SHELL': '/bin/bash', 07:14:32 INFO - 'SHLVL': '1', 07:14:32 INFO - 'TERM': 'linux', 07:14:32 INFO - 'TMOUT': '86400', 07:14:32 INFO - 'USER': 'cltbld', 07:14:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:32 INFO - '_': '/tools/buildbot/bin/python'} 07:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:14:34 INFO - Installing collected packages: mozsystemmonitor 07:14:34 INFO - Running setup.py install for mozsystemmonitor 07:14:34 INFO - Successfully installed mozsystemmonitor 07:14:34 INFO - Cleaning up... 07:14:34 INFO - Return code: 0 07:14:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:14:34 INFO - Using env: {'DISPLAY': ':0', 07:14:34 INFO - 'HOME': '/home/cltbld', 07:14:34 INFO - 'LANG': 'en_US.UTF-8', 07:14:34 INFO - 'LANGUAGE': 'en_US:en', 07:14:34 INFO - 'LOGNAME': 'cltbld', 07:14:34 INFO - 'MAIL': '/var/mail/cltbld', 07:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:34 INFO - 'MOZ_NO_REMOTE': '1', 07:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:34 INFO - 'NO_EM_RESTART': '1', 07:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:34 INFO - 'PWD': '/builds/slave/test', 07:14:34 INFO - 'SHELL': '/bin/bash', 07:14:34 INFO - 'SHLVL': '1', 07:14:34 INFO - 'TERM': 'linux', 07:14:34 INFO - 'TMOUT': '86400', 07:14:34 INFO - 'USER': 'cltbld', 07:14:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:34 INFO - '_': '/tools/buildbot/bin/python'} 07:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:35 INFO - Downloading/unpacking jsonschema==2.5.1 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:37 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:37 INFO - warning: no files found matching '*.txt' 07:14:37 INFO - no previously-included directories found matching 'build' 07:14:37 INFO - no previously-included directories found matching 'dist' 07:14:37 INFO - no previously-included directories found matching '.git*' 07:14:37 INFO - Installing collected packages: jsonschema, functools32 07:14:37 INFO - Running setup.py install for functools32 07:14:37 INFO - warning: no files found matching '*.txt' 07:14:37 INFO - no previously-included directories found matching 'build' 07:14:37 INFO - no previously-included directories found matching 'dist' 07:14:37 INFO - no previously-included directories found matching '.git*' 07:14:37 INFO - Successfully installed jsonschema functools32 07:14:37 INFO - Cleaning up... 07:14:37 INFO - Return code: 0 07:14:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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', '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 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:14: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 functools32==3.2.3-2 07:14:37 INFO - Using env: {'DISPLAY': ':0', 07:14:37 INFO - 'HOME': '/home/cltbld', 07:14:37 INFO - 'LANG': 'en_US.UTF-8', 07:14:37 INFO - 'LANGUAGE': 'en_US:en', 07:14:37 INFO - 'LOGNAME': 'cltbld', 07:14:37 INFO - 'MAIL': '/var/mail/cltbld', 07:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:37 INFO - 'MOZ_NO_REMOTE': '1', 07:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:37 INFO - 'NO_EM_RESTART': '1', 07:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:37 INFO - 'PWD': '/builds/slave/test', 07:14:37 INFO - 'SHELL': '/bin/bash', 07:14:37 INFO - 'SHLVL': '1', 07:14:37 INFO - 'TERM': 'linux', 07:14:37 INFO - 'TMOUT': '86400', 07:14:37 INFO - 'USER': 'cltbld', 07:14:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:37 INFO - '_': '/tools/buildbot/bin/python'} 07:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:14:37 INFO - Cleaning up... 07:14:37 INFO - Return code: 0 07:14:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:14:37 INFO - Using env: {'DISPLAY': ':0', 07:14:37 INFO - 'HOME': '/home/cltbld', 07:14:37 INFO - 'LANG': 'en_US.UTF-8', 07:14:37 INFO - 'LANGUAGE': 'en_US:en', 07:14:37 INFO - 'LOGNAME': 'cltbld', 07:14:37 INFO - 'MAIL': '/var/mail/cltbld', 07:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:37 INFO - 'MOZ_NO_REMOTE': '1', 07:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:37 INFO - 'NO_EM_RESTART': '1', 07:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:37 INFO - 'PWD': '/builds/slave/test', 07:14:37 INFO - 'SHELL': '/bin/bash', 07:14:37 INFO - 'SHLVL': '1', 07:14:37 INFO - 'TERM': 'linux', 07:14:37 INFO - 'TMOUT': '86400', 07:14:37 INFO - 'USER': 'cltbld', 07:14:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:37 INFO - '_': '/tools/buildbot/bin/python'} 07:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:37 INFO - Downloading/unpacking blobuploader==1.2.4 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:40 INFO - Downloading docopt-0.6.1.tar.gz 07:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:40 INFO - Running setup.py install for blobuploader 07:14:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:40 INFO - Running setup.py install for requests 07:14:41 INFO - Running setup.py install for docopt 07:14:41 INFO - Successfully installed blobuploader requests docopt 07:14:41 INFO - Cleaning up... 07:14:41 INFO - Return code: 0 07:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:41 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')]} 07:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:41 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')]} 07:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:41 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 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:41 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 07:14:41 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 07:14:41 INFO - Using env: {'DISPLAY': ':0', 07:14:41 INFO - 'HOME': '/home/cltbld', 07:14:41 INFO - 'LANG': 'en_US.UTF-8', 07:14:41 INFO - 'LANGUAGE': 'en_US:en', 07:14:41 INFO - 'LOGNAME': 'cltbld', 07:14:41 INFO - 'MAIL': '/var/mail/cltbld', 07:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:41 INFO - 'MOZ_NO_REMOTE': '1', 07:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:41 INFO - 'NO_EM_RESTART': '1', 07:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:41 INFO - 'PWD': '/builds/slave/test', 07:14:41 INFO - 'SHELL': '/bin/bash', 07:14:41 INFO - 'SHLVL': '1', 07:14:41 INFO - 'TERM': 'linux', 07:14:41 INFO - 'TMOUT': '86400', 07:14:41 INFO - 'USER': 'cltbld', 07:14:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:41 INFO - '_': '/tools/buildbot/bin/python'} 07:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:41 INFO - Running setup.py (path:/tmp/pip-Oqj2za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:41 INFO - Running setup.py (path:/tmp/pip-m0aySM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:41 INFO - Running setup.py (path:/tmp/pip-4Zad4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:41 INFO - Running setup.py (path:/tmp/pip-Flc9Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:41 INFO - Running setup.py (path:/tmp/pip-U3HoLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:41 INFO - Running setup.py (path:/tmp/pip-cxeZqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:41 INFO - Running setup.py (path:/tmp/pip-63YWSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:41 INFO - Running setup.py (path:/tmp/pip-csjsbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:42 INFO - Running setup.py (path:/tmp/pip-bbM06k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:42 INFO - Running setup.py (path:/tmp/pip-U0aiyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:42 INFO - Running setup.py (path:/tmp/pip-vb3P8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:42 INFO - Running setup.py (path:/tmp/pip-lEZgCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:42 INFO - Running setup.py (path:/tmp/pip-4WoG5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:42 INFO - Running setup.py (path:/tmp/pip-jeueKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:42 INFO - Running setup.py (path:/tmp/pip-ymI0CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:42 INFO - Running setup.py (path:/tmp/pip-YnXba4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:42 INFO - Running setup.py (path:/tmp/pip-xRC57w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:42 INFO - Running setup.py install for manifestparser 07:14:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:42 INFO - Running setup.py install for mozcrash 07:14:42 INFO - Running setup.py install for mozdebug 07:14:42 INFO - Running setup.py install for mozdevice 07:14:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Running setup.py install for mozfile 07:14:43 INFO - Running setup.py install for mozhttpd 07:14:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Running setup.py install for mozinfo 07:14:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Running setup.py install for mozInstall 07:14:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Running setup.py install for mozleak 07:14:43 INFO - Running setup.py install for mozlog 07:14:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Running setup.py install for moznetwork 07:14:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:43 INFO - Running setup.py install for mozprocess 07:14:43 INFO - Running setup.py install for mozprofile 07:14:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:44 INFO - Running setup.py install for mozrunner 07:14:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:44 INFO - Running setup.py install for mozscreenshot 07:14:44 INFO - Running setup.py install for moztest 07:14:44 INFO - Running setup.py install for mozversion 07:14:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:44 INFO - Cleaning up... 07:14:44 INFO - Return code: 0 07:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:14:44 INFO - Using env: {'DISPLAY': ':0', 07:14:44 INFO - 'HOME': '/home/cltbld', 07:14:44 INFO - 'LANG': 'en_US.UTF-8', 07:14:44 INFO - 'LANGUAGE': 'en_US:en', 07:14:44 INFO - 'LOGNAME': 'cltbld', 07:14:44 INFO - 'MAIL': '/var/mail/cltbld', 07:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:44 INFO - 'MOZ_NO_REMOTE': '1', 07:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:44 INFO - 'NO_EM_RESTART': '1', 07:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:44 INFO - 'PWD': '/builds/slave/test', 07:14:44 INFO - 'SHELL': '/bin/bash', 07:14:44 INFO - 'SHLVL': '1', 07:14:44 INFO - 'TERM': 'linux', 07:14:44 INFO - 'TMOUT': '86400', 07:14:44 INFO - 'USER': 'cltbld', 07:14:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:44 INFO - '_': '/tools/buildbot/bin/python'} 07:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:44 INFO - Running setup.py (path:/tmp/pip-Wa5bdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:44 INFO - Running setup.py (path:/tmp/pip-HRT2SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:44 INFO - Running setup.py (path:/tmp/pip-wlMnIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:44 INFO - Running setup.py (path:/tmp/pip-0TAW5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:44 INFO - Running setup.py (path:/tmp/pip-T0FciE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:45 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)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:45 INFO - Running setup.py (path:/tmp/pip-L4YHgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:45 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)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:45 INFO - Running setup.py (path:/tmp/pip-gCYRvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:45 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)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:45 INFO - Running setup.py (path:/tmp/pip-8SCuRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:45 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)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:45 INFO - Running setup.py (path:/tmp/pip-Yl87PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:45 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)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:45 INFO - Running setup.py (path:/tmp/pip-_8t5cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:45 INFO - Running setup.py (path:/tmp/pip-s83rHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:45 INFO - Running setup.py (path:/tmp/pip-zY_xEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:45 INFO - Running setup.py (path:/tmp/pip-Qqe0NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:45 INFO - Running setup.py (path:/tmp/pip-6FnlQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:45 INFO - Running setup.py (path:/tmp/pip-5PIWlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:45 INFO - Running setup.py (path:/tmp/pip-ZwU1xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:45 INFO - Running setup.py (path:/tmp/pip-aPNhXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:14:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:14:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:47 INFO - Downloading blessings-1.6.tar.gz 07:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:47 INFO - Installing collected packages: blessings 07:14:47 INFO - Running setup.py install for blessings 07:14:47 INFO - Successfully installed blessings 07:14:47 INFO - Cleaning up... 07:14:48 INFO - Return code: 0 07:14:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:48 INFO - Reading from file tmpfile_stdout 07:14:48 INFO - Current package versions: 07:14:48 INFO - argparse == 1.2.1 07:14:48 INFO - blessings == 1.6 07:14:48 INFO - blobuploader == 1.2.4 07:14:48 INFO - docopt == 0.6.1 07:14:48 INFO - functools32 == 3.2.3-2 07:14:48 INFO - jsonschema == 2.5.1 07:14:48 INFO - manifestparser == 1.1 07:14:48 INFO - mozInstall == 1.12 07:14:48 INFO - mozcrash == 0.17 07:14:48 INFO - mozdebug == 0.1 07:14:48 INFO - mozdevice == 0.48 07:14:48 INFO - mozfile == 1.2 07:14:48 INFO - mozhttpd == 0.7 07:14:48 INFO - mozinfo == 0.9 07:14:48 INFO - mozleak == 0.1 07:14:48 INFO - mozlog == 3.3 07:14:48 INFO - moznetwork == 0.27 07:14:48 INFO - mozprocess == 0.23 07:14:48 INFO - mozprofile == 0.28 07:14:48 INFO - mozrunner == 6.12 07:14:48 INFO - mozscreenshot == 0.1 07:14:48 INFO - mozsystemmonitor == 0.3 07:14:48 INFO - moztest == 0.7 07:14:48 INFO - mozversion == 1.4 07:14:48 INFO - psutil == 3.1.1 07:14:48 INFO - requests == 1.2.3 07:14:48 INFO - wsgiref == 0.1.2 07:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:48 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 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:48 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 07:14:48 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 07:14:48 INFO - Using env: {'DISPLAY': ':0', 07:14:48 INFO - 'HOME': '/home/cltbld', 07:14:48 INFO - 'LANG': 'en_US.UTF-8', 07:14:48 INFO - 'LANGUAGE': 'en_US:en', 07:14:48 INFO - 'LOGNAME': 'cltbld', 07:14:48 INFO - 'MAIL': '/var/mail/cltbld', 07:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:48 INFO - 'MOZ_NO_REMOTE': '1', 07:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:48 INFO - 'NO_EM_RESTART': '1', 07:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:48 INFO - 'PWD': '/builds/slave/test', 07:14:48 INFO - 'SHELL': '/bin/bash', 07:14:48 INFO - 'SHLVL': '1', 07:14:48 INFO - 'TERM': 'linux', 07:14:48 INFO - 'TMOUT': '86400', 07:14:48 INFO - 'USER': 'cltbld', 07:14:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:48 INFO - '_': '/tools/buildbot/bin/python'} 07:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:14:48 INFO - Cleaning up... 07:14:48 INFO - Return code: 0 07:14:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1426030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1655400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, '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': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', '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 07:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:14:48 INFO - Using env: {'DISPLAY': ':0', 07:14:48 INFO - 'HOME': '/home/cltbld', 07:14:48 INFO - 'LANG': 'en_US.UTF-8', 07:14:48 INFO - 'LANGUAGE': 'en_US:en', 07:14:48 INFO - 'LOGNAME': 'cltbld', 07:14:48 INFO - 'MAIL': '/var/mail/cltbld', 07:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:48 INFO - 'MOZ_NO_REMOTE': '1', 07:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:48 INFO - 'NO_EM_RESTART': '1', 07:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:48 INFO - 'PWD': '/builds/slave/test', 07:14:48 INFO - 'SHELL': '/bin/bash', 07:14:48 INFO - 'SHLVL': '1', 07:14:48 INFO - 'TERM': 'linux', 07:14:48 INFO - 'TMOUT': '86400', 07:14:48 INFO - 'USER': 'cltbld', 07:14:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:48 INFO - '_': '/tools/buildbot/bin/python'} 07:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:14:48 INFO - Cleaning up... 07:14:48 INFO - Return code: 0 07:14:48 INFO - Running post-action listener: _resource_record_post_action 07:14:48 INFO - Running post-action listener: _start_resource_monitoring 07:14:48 INFO - Starting resource monitoring. 07:14:48 INFO - [mozharness: 2016-09-07 14:14:48.727039Z] Finished create-virtualenv step (success) 07:14:48 INFO - [mozharness: 2016-09-07 14:14:48.727506Z] Running install step. 07:14:48 INFO - Running pre-action listener: _resource_record_pre_action 07:14:48 INFO - Running main action method: install 07:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:48 INFO - Reading from file tmpfile_stdout 07:14:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:49 INFO - Reading from file tmpfile_stdout 07:14:49 INFO - Output received: 07:14:49 INFO - Usage: mozinstall [options] installer 07:14:49 INFO - Options: 07:14:49 INFO - -h, --help show this help message and exit 07:14:49 INFO - -d DEST, --destination=DEST 07:14:49 INFO - Directory to install application into. [default: 07:14:49 INFO - "/builds/slave/test"] 07:14:49 INFO - --app=APP Application being installed. [default: firefox] 07:14:49 INFO - mkdir: /builds/slave/test/build/application 07:14:49 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'] 07:14:49 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 07:15:05 INFO - Reading from file tmpfile_stdout 07:15:05 INFO - Output received: 07:15:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:15:05 INFO - Running post-action listener: _resource_record_post_action 07:15:05 INFO - [mozharness: 2016-09-07 14:15:05.035638Z] Finished install step (success) 07:15:05 INFO - [mozharness: 2016-09-07 14:15:05.035916Z] Running run-tests step. 07:15:05 INFO - Running pre-action listener: _resource_record_pre_action 07:15:05 INFO - Running main action method: run_tests 07:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:05 INFO - Python 2.7.3 07:15:05 INFO - Return code: 0 07:15:05 INFO - grabbing minidump binary from tooltool 07:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4570>, '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 0x16e5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e5900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:15:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:15:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:15:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:05 INFO - Return code: 0 07:15:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:15:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:15:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 07:15:05 INFO - Using env: {'DISPLAY': ':0', 07:15:05 INFO - 'HOME': '/home/cltbld', 07:15:05 INFO - 'LANG': 'en_US.UTF-8', 07:15:05 INFO - 'LANGUAGE': 'en_US:en', 07:15:05 INFO - 'LOGNAME': 'cltbld', 07:15:05 INFO - 'MAIL': '/var/mail/cltbld', 07:15:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:05 INFO - 'MOZ_NO_REMOTE': '1', 07:15:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:05 INFO - 'NO_EM_RESTART': '1', 07:15:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:05 INFO - 'PWD': '/builds/slave/test', 07:15:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:05 INFO - 'SHELL': '/bin/bash', 07:15:05 INFO - 'SHLVL': '1', 07:15:05 INFO - 'TERM': 'linux', 07:15:05 INFO - 'TMOUT': '86400', 07:15:05 INFO - 'USER': 'cltbld', 07:15:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038', 07:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:05 INFO - '_': '/tools/buildbot/bin/python'} 07:15:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:15:05 INFO - mozversion application_buildid: 20160907004009 07:15:05 INFO - mozversion application_changeset: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 07:15:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:15:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:05 INFO - mozversion application_name: Firefox 07:15:05 INFO - mozversion application_remotingname: firefox-dev 07:15:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:15:05 INFO - mozversion application_vendor: Mozilla 07:15:05 INFO - mozversion application_version: 50.0a2 07:15:05 INFO - mozversion platform_buildid: 20160907004009 07:15:05 INFO - mozversion platform_changeset: 3a0fd1bb116a3b79b6f33462a04144818b550ee9 07:15:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:15:05 INFO - mozversion platform_version: 50.0a2 07:15:05 INFO - using testdate: 1473257705 07:15:05 INFO - actual date: 1473257705 07:15:05 INFO - starting webserver on 'localhost:48359' 07:15:05 INFO - SUITE-START | Running 2 tests 07:15:05 INFO - TEST-START | dromaeo_css 07:15:05 INFO - operating with platform_type : linux_ 07:15:05 INFO - Initialising browser for dromaeo_css test... 07:15:05 INFO - TEST-INFO | started process 4011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIEAYWW/profile http://localhost:48359/getInfo.html) 07:15:10 INFO - PROCESS | 4011 | __metrics Screen width/height:1600/1200 07:15:10 INFO - PROCESS | 4011 | colorDepth:24 07:15:10 INFO - PROCESS | 4011 | Browser inner width/height: 1024/697 07:15:10 INFO - PROCESS | 4011 | __metrics 07:15:10 ERROR - PROCESS | 4011 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:15:11 INFO - TEST-INFO | 4011: exit 0 07:15:11 INFO - Browser initialized. 07:15:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:11 INFO - TEST-INFO | started process 4136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIEAYWW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:23 INFO - PROCESS | 4136 | RSS: Main: 152506368 07:15:23 INFO - PROCESS | 4136 | 07:16:13 INFO - PROCESS | 4136 | 1473257773141 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] 07:18:21 INFO - PROCESS | 4136 | Cycle 1(1): loaded http://localhost:48359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48359/tests/dromaeo/cssquery-ext.html) 07:18:22 INFO - PROCESS | 4136 | RSS: Main: 158556160 07:18:22 INFO - PROCESS | 4136 | 07:21:24 INFO - PROCESS | 4136 | Cycle 1(1): loaded http://localhost:48359/tests/dromaeo/cssquery-ext.html (next: http://localhost:48359/tests/dromaeo/cssquery-jquery.html) 07:21:25 INFO - PROCESS | 4136 | RSS: Main: 154275840 07:21:25 INFO - PROCESS | 4136 | 07:24:27 INFO - PROCESS | 4136 | Cycle 1(1): loaded http://localhost:48359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48359/tests/dromaeo/cssquery-mootools.html) 07:24:27 INFO - PROCESS | 4136 | RSS: Main: 154378240 07:24:27 INFO - PROCESS | 4136 | 07:27:29 INFO - PROCESS | 4136 | Cycle 1(1): loaded http://localhost:48359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48359/tests/dromaeo/cssquery-prototype.html) 07:27:30 INFO - PROCESS | 4136 | RSS: Main: 153100288 07:27:30 INFO - PROCESS | 4136 | 07:30:32 INFO - PROCESS | 4136 | Cycle 1(1): loaded http://localhost:48359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48359/tests/dromaeo/cssquery-yui.html) 07:30:33 INFO - PROCESS | 4136 | RSS: Main: 155463680 07:30:33 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | Cycle 1(1): loaded http://localhost:48359/tests/dromaeo/cssquery-yui.html (next: http://localhost:48359/tests/dromaeo/cssquery-dojo.html) 07:33:35 INFO - PROCESS | 4136 | RSS: Main: 156049408 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | __start_tp_report 07:33:35 INFO - PROCESS | 4136 | _x_x_mozilla_page_load 07:33:35 INFO - PROCESS | 4136 | _x_x_mozilla_page_load_details 07:33:35 INFO - PROCESS | 4136 | |i|pagename|runs| 07:33:35 INFO - PROCESS | 4136 | |0;dojo.html;3272.8690852365908;3292.1111299949016;3310.58617672791;3312.420326442872;3315.751318651102;5682.119271512912;5696.6866822324755;5732.054211055176;5752.884942301152;5774.105013722869;5664.291963504562;5764.452377024187;5796.304443466779;5798.913016304748;5804.709764511768;5228.163493840977;5254.21186821976;5254.395744489375;5305.442928492511;5315.069862773999;5182.196759502264;5223.216517522383;5229.895402091975;5267.420583735786;5305.4164041955355;5248.895022099556;5253.789848406059;5262.973685131569;5275.683458992473;5334.51989320961;5268.9473105269035;5306.681599104066;5313.256144139824;5314.92027619586;5341.118715411992;4990.675606085593;4992.725400102993;5023.748812559357;5224.425313215544;5225.294585230983;5505.972470137664;5540.418256083093;5547.861303467405;5557.777688892439;5614.747336369873;5964.343922168558;5967.343592204854;5989.850253743648;5997.490213331872;6045.879082418327;5864.442877926633;5964.761409543613;6001.189839371673;6029.366916473795;6033.607815491979;5663.235463212413;5666.405027472098;5674.602777805555;5681.346645135821;5681.517071048966;6174.9073763893575;6183.412575805291;6185.381461853779;6195.19462469885;6197.318294987548;5844.649321040752;5876.7355469004;5906.5570082244;5947.464728174398;5975.611585246945;6034.879302413927;6045.969770151121;6051.243594550681;6075.848103797441;6077.453029227391;5971.223740913653;6020.939790602038;6024.789132380346;6024.879502409927;6057.697115144225;5809.680467574324;5924.170616113747;5927.318358388754;5962;6054.212952316171;4586.3579098926175;4589.472210695746;4605.792739326738;4606.262997920317;4614.653900957442;4124.030852749602;4130.339145736728;4135.545090040093;4138.937915931264;4175.54069052404;5774.2782152230975;5777.422257774189;5787.884242315215;5792.710364481759;5809.390014048548;6135.987562052301;6152.169457123231;6152.692365381713;6164.876702466016;6184.81445556634;5911.113332999998;5939.524838012949;5943.138244954457;5951.1073338999495;5951.732172052268;5151.5621172200035;5290.709011004432;5305.1776974569;5322;5345.278387417727;6409.583377080475;6457.1282876811965;6461.160049193575;6470.2559205691;6492.64290464029;6218.440340369389;6248.4064013918605;6266.655333956493;6269.749210031548;6282.403171698681;6126.578745377076;6144.907826382697;6169.598976066542;6216;6483.481321494363;5983.401659833982;5989.5507836913275;5990.131430942576;5990.9700451497465;5991.64050156992;6066.272047354346;6066.636001839904;6067.302260239952;6069.2110025696375;6088.238970128734;5777.768889244551;5931.258592675916;6019.578629495893;6038.215032045806;6043.3050199227655;6007.219061521974;6071.089336599545;6071.453569178795;6075.1798507200965;6091.451769340603;5954.672493012926;5962.9105563415715;5986.371430999857;6008.969955150196;6017.488513476228;5706.600537962303;5793.971030144822;5836.795712150054;5839.211706419749;6081.969590152021;5753.827385178452;5772.913406298825;5775.624584402;5791.073428251628;5796.681182535001 07:33:35 INFO - PROCESS | 4136 | |1;ext.html;590.2503820148412;627.8618703885144;648.0732552449996;665.2416245480152;677;40619.39070913935;45590.772046139726;45634.087318253616;45669.314960275624;45677;45018;45308.546914530845;45356;45508;45521.317180242324;8941.910580894206;8968.192862642361;9061.818763624724;9071.365004449659;9075.773105672379;9015.413998090104;9110.134537218953;9119.042500537447;9162.083791620818;9171.724848254564;9134.223590994774;9163.312751543628;9188.770280742969;9194.678186263482;9203.585838637244;9103.817923641524;9106.544672766368;9109.225715814098;9142.268618510536;9171.954140229256;8932.910670893272;9013.594388252479;9034.45793252407;9038.638454461814;9060.68287609937;43235.56764432347;43496.782516087536;43546.346804797955;43577;43812.780936095114;3725.6274372562525;3770.566384865748;3779.981100094509;3832.2910261601414;4076;34681.30637387238;34942.30115397703;35075.64924350749;35317;35555.822220888986;4480.529544397857;4511.097780443892;4543.136804007261;4543.273076307808;4618.607418369443;347123;350969;351178;353290.99999999744;354016;54602;54606.45393546093;54655.18017229745;54835.72582137064;54918.450815492135;39234.60765392367;39767.60232397697;40414.59585404109;41905;42072.36891446631;18008.549786255448;18076.36732714375;18109;18142.909285453487;18143.364982225823;12349.259044457362;12401;12410.503579856886;12440.75118497625;12449.066320026035;20591.176352945713;20615.8969205153;20832.79167208339;20867.895660521903;20905.790942090385;7469.253074692488;7488.588127653032;7498.85002299951;7611.619419029026;7820.530768153815;1014.183582216323;1055.2771351624162;1070.5610699613278;1098.6429410441638;1234.672811704899;33742.662573374444;34114.658853411645;34316.313673726385;34447.655523444446;34903.4764478533;1163.7207070303066;1194.808830587102;1235.8702336254744;1246.2647038247296;1264.9114561980757;16895.241903238802;17155.91422042882;17400.303987840343;17448.302067917142;17609.207585658674;578464;579815;583778;584493;585593;61169.38830611726;61507;61519.38480615226;61625;61678;1483.9851601483847;1487.2043456750803;1514.4245186829155;1518.1953564610774;1523.6419441431256;31802.840985794923;32291.51562726514;32395.51406728948;32698.83650581732;33124.66875331216;53208.20187697265;53971.46028539664;54283;54329.456705432436;54346.18480722872;526363;527901;531193;531824;533250;29772.255693607833;30365.392692146474;30394.696053039188;30551.847240763655;30565.54151687771;50025.49974500208;50255.74872125616;50576;50682.493175069256;50760.23859642034;42750.786246069816;43230;43749;43904.56095439005;44519;43364.78317608392;43394.349084764384;43563.56436435722;43759;44068.77965610151;37022.629773702996;39967.80016099901;40388.79805600953;40518.59481405266;41827.58172418358;36801.63198367982;38236.90146163081;38250.617493824706;38266.61733382742;38372.808135959145;28622.427551448436;29288.853555732087;29298.585256887563;29318;29517.557236641896 07:33:35 INFO - PROCESS | 4136 | |2;jquery.html;418.474814108294;420.8674267605702;426.47117574207994;426.5095140588323;431.8121617096563;19456.41630751078;19880.801191988077;21002.369928902157;21107.788922110773;21304.360869173932;19239.326623568177;19816.900915495404;20052.59894802103;20221.39335819928;20572;5301.098813201756;5496.422875598065;5500.80747173849;5501.477359650827;5501.559875209994;5390.164524498709;5462.754176062087;5488.5609151268;5569.331680198382;5797.478226959573;5895.941040589603;5913.408659134096;5954.612950158225;5956.463918247357;5968.552358573124;5873.970630146843;5938.7624495020145;6207.410296021871;6379.266384365811;6380.234371875358;6141.4472697456995;6203.658798766066;6206.689665516751;6224.190855188842;6249.78125765596;14656.560303190921;14820;14888.702225955529;23371.53256934869;24490.387740306636;2448.375664205616;2724.7002829688718;3088.722015018659;3187.569678093451;3233.5634689316876;14301.642458938506;15152.772708409382;15220.315085821165;15397.846021539754;15487.612809679735;2008.5279959209574;2009.0141686795018;2039.7960203979633;2088.091680119153;2113.6829475578634;87527;88504;89210.5539472305;89980;90663;11011.83482247767;11344.48949797261;11797.941010294893;11984.161108722481;12251.387430628432;16916.915415422845;16944;17073.7438938416;17082;17097.230624621923;8239.217274358927;8255.133211012877;8449.493030418194;8676.479411235347;8828.690995815115;7561.281678240558;7627.580483073484;7629.351505122016;7690.884636730453;7787.571683557346;4981.676191047571;4990.575801056878;5029.899402012013;5051.823186188466;5245.816396426107;2092.872462466962;2147.2591955775233;2170.934871953844;2175.564887022602;2191.29878438898;969.5103972493846;1058.327961744298;1085.6417382263835;1145.6391236760394;1177.370106992772;21043.47391315199;21122.682296087012;21132.732036077883;21162.576748465253;21444.463888402915;1026.9691909242736;1033.4884232305058;1038.2420832792104;1040.3549799124592;1095.0746619106842;11355.716107097389;11740.473738414123;11944.343061131547;11985.460654270404;12038.277703337828;472936;482836;493302;519966;527711;95992.52003740077;96148;96896.51551742195;97150;100021;1052.9894701052892;1068.9625863094755;1070.6359837655234;1074.1299547366657;1086.4241951765578;15757.763633545736;17400.129993500526;17975.460736177934;18536.721949170504;18994.050297485348;41679.374809377274;42277;42337;42645.14709705851;42756.1448771029;57512;59260.70369648297;59879.401205989125;59916.40083599108;61858.38141618706;9143.542822858963;9147.77130571741;9181.495017774087;9221.400608960395;9238.538073096453;10106.932908465218;14237.786433203717;14404.927975360057;14496.275186240857;14703;11647;11666.824997624874;11729.178957473236;11745.823812642988;12489.93755031219;11684.357360344922;11983.880161198626;12087.335196564274;12145.757084858076;12306.815397768862;11808;11921.225120367495;12219.327936963553;12309.56916507918;12318.199317044364;8930.687425940061;8986.595603198002;9130.178283954476;9216.493092879957;9341.906580934103;11496.655100347003;11955.402229888645;12134;12210.450529726006;12527.248365098123 07:33:35 INFO - PROCESS | 4136 | |3;mootools.html;1560.5552417560993;1578.4080969636386;1785.6517978994093;1866.6266746650674;1880.9341673041447;8059.516429014263;9036.141566551183;9369.765755856099;10104.545295461703;10116.74708132297;9476.81046379072;9866;9867;9871.210303175747;9877.60489580416;2438.5122975404947;2461.59383701689;2474.2453551666736;2479.7024357077175;2484.3043947694673;2375.192434572245;2489.390099425634;2507.2227609441134;2507.8244522883406;2508.2224510401834;2304.562133194696;2307.976920230793;2313.6182529882635;2318.6058370077044;2324.0936034946385;2387.7254115776645;2389.4623709665275;2390.3904504351367;2397.568437681217;2420.9273721788372;2295.024614538831;2326.592846251916;2359.7522260162777;2369;2370.2059809963685;9397.436153830724;9514.28642851789;9515.666951656658;9598.424094554279;9604.855927161097;5574.86062848428;5641.238432811559;5716.314042314949;5723.742431590588;5733.512651424634;3470.826458677056;3547.2018795770746;3591.299696559172;3604.5494313210847;3635.2729454109285;1161.7386088130188;1211.0493262788668;1221.1567648800446;1230.1266101068252;1230.772307123185;13838.861611383958;13862.306884655727;13897.0966887152;13914.791278130837;14013.299335033309;4729.498987879344;4786.880327991758;4790.4251489821445;4908.509149085135;4916.360873086476;11012.559497620166;11023;11041.889581104086;11051.944740276247;11056.060234880126;5641.26663533738;5734.799282025109;5740.454656807597;5766.740496677659;5769.740361683735;4365.3670217818235;5146.382434107856;5177.0940085485645;5239.895202096013;5391.4608539145775;3963.5243770747693;4019.959800402017;4061.086255592468;4074.714769966074;4105.281575724236;1169.6081812592877;1204.6988252936767;1209.8245754365569;1210.9939450302868;1222.0834374219335;1044.5090807320548;1053.7787064716342;1068.8877667844765;1070.5824728355947;1080.621782376162;6207.751689932352;6507;6614;6629.9337006630285;6839.93160068393;1029.5264178477835;1034.4930983818026;1063.8936106389299;1076.8277075667856;1088.1349327284827;4447.955520444819;4455.532169122195;4460.799264033127;4496.3255511673515;4562.566556177224;12335.568255111028;12347.259164450163;12624.684382890318;12702.364881755875;12830.679233019062;12566.937165314115;12632.621021369374;12732.936335318263;12743;12744.936275318563;8985;9063.184313411824;9266.44401335922;9391.953040234892;9415.105564971316;6682.83292917681;6752.696128674123;6762.120924279812;6782.389584937379;6857.348551887562;11463;11659.067274618179;11709.473073711533;11721.296722196696;11735.941320293345;11598.304101753922;11621.418929053345;11919.582814601446;11932.701682458008;11944.04447644169;8094.352451803724;8249.711260105867;8250.711225107092;8363.665453381796;8404.915950840414;9420.62317507292;9641.758956026155;9701.466419347003;9722.611095556098;9739.561719722771;8742.82514349722;8786.077461866667;8818.162274583905;8942.418742781698;8956.104389560991;8504.107068757692;8581.184787445183;8611;8690.522021288889;8767.780805479659;7551.056117985252;7678.308952194329;7690.961545192238;7697.114831794192;7698.653560589899;5757.884842303214;5821.330546986981;5825.300963884361;5865.677387743715;5902.61632993854;5430.592705547021;5437.510624043855;5524.613277070566;5535.114381698909;5569.220309156803 07:33:35 INFO - PROCESS | 4136 | |4;prototype.html;336.35587849268654;348.30339321357286;353.05205523170275;353.2370080625849;355.6461320985618;5740.253767010288;5815.912761308578;5862.912056319158;5873.735681894314;5925.4963328117165;5662.150677398392;5714.428557144283;5721.7711291548285;5763.049096899007;5805.883882322351;4440.356148358486;4573.9085218295695;4599.8390056348035;4613.2388155954395;4621.630269578425;4568.497465278817;4573.885652858672;4582.633389328862;4598.839040633578;4609.193391156551;4512.864614061584;4561.521040290755;4581.954180458203;4592.196365636017;4617.376654151697;4433.778311084465;4538.410006699141;4549.795259213327;4557.74932378719;4562.4753153387455;4037.777922214277;4059.3099173140636;4060.796960151981;4070.1656160487028;4081.7142600081174;5686.175504551817;5712.714364281769;5730.656160630376;5736.483716465496;5736.971315143439;5081.8729531762;5242.97378513105;5260.132078207092;5271.42014378418;5306.09796334624;6119.877602447926;6147.508199344042;6154.138420621117;6164.229471316085;6165.568410211287;4497.797599108048;4504.842330518416;4508.887277818048;4511.150428324404;4511.278195488706;6207.565470417073;6323;6339.144215530937;6410.679466026727;6413.262474815409;4547.067851090585;4579.564941330568;4593.977030114895;4609.631229501631;4621.976890115595;4643.628509719214;4647.070585882837;4650.581447669659;4654.115718013634;4673.182193116191;4972.303877457159;5223.451537588575;5232.136697444955;5275.736213189325;5314.388845282765;6072.330109219912;6076.389756714474;6119.684267882427;6125.142480052797;6133.539984501091;1574.7559128334897;1588.6663800601773;1617.2964760329294;1619.9757003644954;1623.091069001363;1010.1666125446536;1012.8683271174848;1012.9139023182964;1013.8580598716186;1037.9896201037893;5270.285802811555;5275.709835959059;5287.836675931289;5290.68255904647;5307.734613269321;5402.783888644489;5485.6434331768305;5490.72135063952;5585.636933599384;5591.217229587861;5353.153162159049;5602.97198514013;6015.699215039231;6031.215941927521;6034.24571928509;3333.466645336783;3346.380919529895;3380.7295416366633;3391.898243052663;3396.3886500429667;6324.494040476751;6471.805845824539;6492;6602.14172157626;6618.569792963538;6123.091531522491;6310.4636105930595;6389.808305750835;6396.569303664671;6439.549231553746;6410.711517981702;6529.869402611921;6568.671566421755;6570.8357291068105;6624.635645039569;6257.874842503215;6287.937120628735;6327.766085613262;6337.334579869047;6356.745730170926;6060.636361818305;6144.201253836973;6183.093945845446;6228.813135605939;6259.499240060693;6450.29067297176;6524.836879078061;6544.574602651003;6551.60690358561;6602.933970660232;4304.504981927118;4385.978070109629;4387.451568553931;4410.757408342572;4437.445319335083;6242.094896239929;6255.529950461547;6287.830698409041;6316.842078948063;6322.905156422566;5965.970170149121;6157.507399407947;6214.768320473238;6225.657588832658;6229.3770622937345;6011;6086.665233412028;6101.60339577926;6123.326434092335;6128.32588415265;6044.153818465506;6098.146259523582;6100.115483254992;6101.908471373022;6131.509479241739;5947.197128387786;6044.818655440344;6106.45041946227;6137.355577664281;6237.625742455467;5921.4966727826895;5954.10688396744;5972.820815375546;6000.76984218243;6021.2904193114155 07:33:35 INFO - PROCESS | 4136 | |5;yui.html;802.386174576449;806.2904643913357;814.4950130918832;820.380612637459;924.5192499900048;15710.371585136596;16716.582085447855;16791.66416671666;16892.493225203234;16923.830761692396;15180.165090919994;15226.314815833286;15233.695326093499;15250.084994900313;15318.617034574141;722.9963850180768;836.619338201117;860.6858496648741;883.0507204754882;883.5052370672412;886.2644005475472;891.01542795211;893.2139717048988;895.1093661806511;899.2221728205121;940.3981451870808;941.4163218804351;941.7221919533754;942.575840871607;943.0899182289089;934.9672761453351;935.1209862729013;938.4088024544527;938.6714649872524;940.6989763275755;687.2028447001454;691.3881215124601;691.6472598974509;692.0207905813268;697.1947400752089;14886.10683359002;14899.255037248095;14903.850961490463;14929.10425374481;14940.62648433787;15902.363905443768;16767.161641917854;16860.241289142017;17123.058231797248;17235.91382043082;13145.211287322696;13234.73530529384;13304.334783260894;13382.397792099282;13388.464461421532;3965.405189221611;4021.9360232498043;4040.575739547364;4058.472398588194;4101.774402407867;88220.99999999936;88424.55787721084;88473.55763221208;88973;89092;12454.750904982031;13130.540431084866;13377.665558360924;13425.597232083053;13547.390367433489;25972.220833375028;26093.73906260951;26337.604935925978;26514.337141571614;26965.595516067275;8886.644534218558;9208.861867071999;9340.206082483064;9406.43561386319;9441.76395590102;5009.849704508798;5089.491050894955;5156.690598564098;5288.867778305496;5477.726113694379;3544.3620148373025;3661.8169091545315;3667.9633203668154;3695.0392897846214;3720.3489389357296;625.6652690810395;629.222909706512;690.492488021304;716.874546954281;728.4318231779221;640.1262276991872;789.9328557072713;840.609116760697;851.3104385447807;858;9458.810823783486;9831.557579908922;10308.896911030793;10480.68557943263;10520.631777887736;770.4722265248323;783.7178615698344;793.9801504962306;801.7640791853569;809.8501777171242;5027.321311622884;5242.52817246442;5279.234510995961;5375.6774593524515;5389.487998640123;131362;134005;134349;135368.32315838357;139687;114112;116925;118803;120700;125127;88711.55644221867;94954.52522737342;96850;98637.50681246692;103661;9291.535423228946;9813.705588832347;9865.704028879145;9903.752406189902;9906.653267135616;48560.271595925384;49863.501364987336;61857.690711547955;62101.68949155225;63147.6842615784;49906.75046624744;52325.7383713079;53696.731516342166;53831.73084134554;62226;14452.783208251674;14475.710485790436;14695.265236738334;14743.852561474678;14821;14694.77957830612;14885.702285954438;15215.08709477435;15397.923010384877;15524.37902483888;14776.48282310114;15010.699786004438;15679.216039198223;15719.135447550494;15876.364945402054;13511.459541618226;13883.583492495241;14261.64345891361;14380.56858294253;14553.417863285349;13259.602211933658;14294.928525357307;14443.927780361031;15346.616334591725;15533.533993980198;11769.17615766888;12008.519659213534;12363.32001739913;12390.602493418837;12727.809082863949;11548;11616.361100139573;11709.297442153498;11816.350100744541;11878.584249551224 07:33:35 INFO - PROCESS | 4136 | __end_tp_report 07:33:35 INFO - PROCESS | 4136 | __start_cc_report 07:33:35 INFO - PROCESS | 4136 | _x_x_mozilla_cycle_collect,313 07:33:35 INFO - PROCESS | 4136 | __end_cc_report 07:33:35 INFO - PROCESS | 4136 | __startTimestamp1473258815660__endTimestamp 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | ------- Summary: start ------- 07:33:35 INFO - PROCESS | 4136 | Number of tests: 6 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | [#0] dojo.html Cycles:165 Average:5662.01 Median:5864.44 stddev:640.07 (10.9%) stddev-sans-first:613.98 07:33:35 INFO - PROCESS | 4136 | Values: 3272.9 3292.1 3310.6 3312.4 3315.8 5682.1 5696.7 5732.1 5752.9 5774.1 5664.3 5764.5 5796.3 5798.9 5804.7 5228.2 5254.2 5254.4 5305.4 5315.1 5182.2 5223.2 5229.9 5267.4 5305.4 5248.9 5253.8 5263.0 5275.7 5334.5 5268.9 5306.7 5313.3 5314.9 5341.1 4990.7 4992.7 5023.7 5224.4 5225.3 5506.0 5540.4 5547.9 5557.8 5614.7 5964.3 5967.3 5989.9 5997.5 6045.9 5864.4 5964.8 6001.2 6029.4 6033.6 5663.2 5666.4 5674.6 5681.3 5681.5 6174.9 6183.4 6185.4 6195.2 6197.3 5844.6 5876.7 5906.6 5947.5 5975.6 6034.9 6046.0 6051.2 6075.8 6077.5 5971.2 6020.9 6024.8 6024.9 6057.7 5809.7 5924.2 5927.3 5962.0 6054.2 4586.4 4589.5 4605.8 4606.3 4614.7 4124.0 4130.3 4135.5 4138.9 4175.5 5774.3 5777.4 5787.9 5792.7 5809.4 6136.0 6152.2 6152.7 6164.9 6184.8 5911.1 5939.5 5943.1 5951.1 5951.7 5151.6 5290.7 5305.2 5322.0 5345.3 6409.6 6457.1 6461.2 6470.3 6492.6 6218.4 6248.4 6266.7 6269.7 6282.4 6126.6 6144.9 6169.6 6216.0 6483.5 5983.4 5989.6 5990.1 5991.0 5991.6 6066.3 6066.6 6067.3 6069.2 6088.2 5777.8 5931.3 6019.6 6038.2 6043.3 6007.2 6071.1 6071.5 6075.2 6091.5 5954.7 5962.9 5986.4 6009.0 6017.5 5706.6 5794.0 5836.8 5839.2 6082.0 5753.8 5772.9 5775.6 5791.1 5796.7 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | [#1] ext.html Cycles:180 Average:64439.27 Median:43445.57 stddev:132429.73 (304.8%) stddev-sans-first:132714.47 07:33:35 INFO - PROCESS | 4136 | Values: 590.3 627.9 648.1 665.2 677.0 40619.4 45590.8 45634.1 45669.3 45677.0 45018.0 45308.5 45356.0 45508.0 45521.3 8941.9 8968.2 9061.8 9071.4 9075.8 9015.4 9110.1 9119.0 9162.1 9171.7 9134.2 9163.3 9188.8 9194.7 9203.6 9103.8 9106.5 9109.2 9142.3 9172.0 8932.9 9013.6 9034.5 9038.6 9060.7 43235.6 43496.8 43546.3 43577.0 43812.8 3725.6 3770.6 3780.0 3832.3 4076.0 34681.3 34942.3 35075.6 35317.0 35555.8 4480.5 4511.1 4543.1 4543.3 4618.6 347123.0 350969.0 351178.0 353291.0 354016.0 54602.0 54606.5 54655.2 54835.7 54918.5 39234.6 39767.6 40414.6 41905.0 42072.4 18008.5 18076.4 18109.0 18142.9 18143.4 12349.3 12401.0 12410.5 12440.8 12449.1 20591.2 20615.9 20832.8 20867.9 20905.8 7469.3 7488.6 7498.9 7611.6 7820.5 1014.2 1055.3 1070.6 1098.6 1234.7 33742.7 34114.7 34316.3 34447.7 34903.5 1163.7 1194.8 1235.9 1246.3 1264.9 16895.2 17155.9 17400.3 17448.3 17609.2 578464.0 579815.0 583778.0 584493.0 585593.0 61169.4 61507.0 61519.4 61625.0 61678.0 1484.0 1487.2 1514.4 1518.2 1523.6 31802.8 32291.5 32395.5 32698.8 33124.7 53208.2 53971.5 54283.0 54329.5 54346.2 526363.0 527901.0 531193.0 531824.0 533250.0 29772.3 30365.4 30394.7 30551.8 30565.5 50025.5 50255.7 50576.0 50682.5 50760.2 42750.8 43230.0 43749.0 43904.6 44519.0 43364.8 43394.3 43563.6 43759.0 44068.8 37022.6 39967.8 40388.8 40518.6 41827.6 36801.6 38236.9 38250.6 38266.6 38372.8 28622.4 29288.9 29298.6 29318.0 29517.6 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | [#2] jquery.html Cycles:180 Average:30071.31 Median:2173.25 stddev:82563.24 (3799.1%) stddev-sans-first:82764.83 07:33:35 INFO - PROCESS | 4136 | Values: 418.5 420.9 426.5 426.5 431.8 19456.4 19880.8 21002.4 21107.8 21304.4 19239.3 19816.9 20052.6 20221.4 20572.0 5301.1 5496.4 5500.8 5501.5 5501.6 5390.2 5462.8 5488.6 5569.3 5797.5 5895.9 5913.4 5954.6 5956.5 5968.6 5874.0 5938.8 6207.4 6379.3 6380.2 6141.4 6203.7 6206.7 6224.2 6249.8 14656.6 14820.0 14888.7 23371.5 24490.4 2448.4 2724.7 3088.7 3187.6 3233.6 14301.6 15152.8 15220.3 15397.8 15487.6 2008.5 2009.0 2039.8 2088.1 2113.7 87527.0 88504.0 89210.6 89980.0 90663.0 11011.8 11344.5 11797.9 11984.2 12251.4 16916.9 16944.0 17073.7 17082.0 17097.2 8239.2 8255.1 8449.5 8676.5 8828.7 7561.3 7627.6 7629.4 7690.9 7787.6 4981.7 4990.6 5029.9 5051.8 5245.8 2092.9 2147.3 2170.9 2175.6 2191.3 969.5 1058.3 1085.6 1145.6 1177.4 21043.5 21122.7 21132.7 21162.6 21444.5 1027.0 1033.5 1038.2 1040.4 1095.1 11355.7 11740.5 11944.3 11985.5 12038.3 472936.0 482836.0 493302.0 519966.0 527711.0 95992.5 96148.0 96896.5 97150.0 100021.0 1053.0 1069.0 1070.6 1074.1 1086.4 15757.8 17400.1 17975.5 18536.7 18994.1 41679.4 42277.0 42337.0 42645.1 42756.1 57512.0 59260.7 59879.4 59916.4 61858.4 9143.5 9147.8 9181.5 9221.4 9238.5 10106.9 14237.8 14404.9 14496.3 14703.0 11647.0 11666.8 11729.2 11745.8 12489.9 11684.4 11983.9 12087.3 12145.8 12306.8 11808.0 11921.2 12219.3 12309.6 12318.2 8930.7 8986.6 9130.2 9216.5 9341.9 11496.7 11955.4 12134.0 12210.5 12527.2 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | [#3] mootools.html Cycles:180 Average:6414.64 Median:4090.00 stddev:3789.70 (92.7%) stddev-sans-first:3782.78 07:33:35 INFO - PROCESS | 4136 | Values: 1560.6 1578.4 1785.7 1866.6 1880.9 8059.5 9036.1 9369.8 10104.5 10116.7 9476.8 9866.0 9867.0 9871.2 9877.6 2438.5 2461.6 2474.2 2479.7 2484.3 2375.2 2489.4 2507.2 2507.8 2508.2 2304.6 2308.0 2313.6 2318.6 2324.1 2387.7 2389.5 2390.4 2397.6 2420.9 2295.0 2326.6 2359.8 2369.0 2370.2 9397.4 9514.3 9515.7 9598.4 9604.9 5574.9 5641.2 5716.3 5723.7 5733.5 3470.8 3547.2 3591.3 3604.5 3635.3 1161.7 1211.0 1221.2 1230.1 1230.8 13838.9 13862.3 13897.1 13914.8 14013.3 4729.5 4786.9 4790.4 4908.5 4916.4 11012.6 11023.0 11041.9 11051.9 11056.1 5641.3 5734.8 5740.5 5766.7 5769.7 4365.4 5146.4 5177.1 5239.9 5391.5 3963.5 4020.0 4061.1 4074.7 4105.3 1169.6 1204.7 1209.8 1211.0 1222.1 1044.5 1053.8 1068.9 1070.6 1080.6 6207.8 6507.0 6614.0 6629.9 6839.9 1029.5 1034.5 1063.9 1076.8 1088.1 4448.0 4455.5 4460.8 4496.3 4562.6 12335.6 12347.3 12624.7 12702.4 12830.7 12566.9 12632.6 12732.9 12743.0 12744.9 8985.0 9063.2 9266.4 9392.0 9415.1 6682.8 6752.7 6762.1 6782.4 6857.3 11463.0 11659.1 11709.5 11721.3 11735.9 11598.3 11621.4 11919.6 11932.7 11944.0 8094.4 8249.7 8250.7 8363.7 8404.9 9420.6 9641.8 9701.5 9722.6 9739.6 8742.8 8786.1 8818.2 8942.4 8956.1 8504.1 8581.2 8611.0 8690.5 8767.8 7551.1 7678.3 7691.0 7697.1 7698.7 5757.9 5821.3 5825.3 5865.7 5902.6 5430.6 5437.5 5524.6 5535.1 5569.2 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | [#4] prototype.html Cycles:180 Average:5134.08 Median:5718.10 stddev:1498.23 (26.2%) stddev-sans-first:1458.51 07:33:35 INFO - PROCESS | 4136 | Values: 336.4 348.3 353.1 353.2 355.6 5740.3 5815.9 5862.9 5873.7 5925.5 5662.2 5714.4 5721.8 5763.0 5805.9 4440.4 4573.9 4599.8 4613.2 4621.6 4568.5 4573.9 4582.6 4598.8 4609.2 4512.9 4561.5 4582.0 4592.2 4617.4 4433.8 4538.4 4549.8 4557.7 4562.5 4037.8 4059.3 4060.8 4070.2 4081.7 5686.2 5712.7 5730.7 5736.5 5737.0 5081.9 5243.0 5260.1 5271.4 5306.1 6119.9 6147.5 6154.1 6164.2 6165.6 4497.8 4504.8 4508.9 4511.2 4511.3 6207.6 6323.0 6339.1 6410.7 6413.3 4547.1 4579.6 4594.0 4609.6 4622.0 4643.6 4647.1 4650.6 4654.1 4673.2 4972.3 5223.5 5232.1 5275.7 5314.4 6072.3 6076.4 6119.7 6125.1 6133.5 1574.8 1588.7 1617.3 1620.0 1623.1 1010.2 1012.9 1012.9 1013.9 1038.0 5270.3 5275.7 5287.8 5290.7 5307.7 5402.8 5485.6 5490.7 5585.6 5591.2 5353.2 5603.0 6015.7 6031.2 6034.2 3333.5 3346.4 3380.7 3391.9 3396.4 6324.5 6471.8 6492.0 6602.1 6618.6 6123.1 6310.5 6389.8 6396.6 6439.5 6410.7 6529.9 6568.7 6570.8 6624.6 6257.9 6287.9 6327.8 6337.3 6356.7 6060.6 6144.2 6183.1 6228.8 6259.5 6450.3 6524.8 6544.6 6551.6 6602.9 4304.5 4386.0 4387.5 4410.8 4437.4 6242.1 6255.5 6287.8 6316.8 6322.9 5966.0 6157.5 6214.8 6225.7 6229.4 6011.0 6086.7 6101.6 6123.3 6128.3 6044.2 6098.1 6100.1 6101.9 6131.5 5947.2 6044.8 6106.5 6137.4 6237.6 5921.5 5954.1 5972.8 6000.8 6021.3 07:33:35 INFO - PROCESS | 4136 | 07:33:35 INFO - PROCESS | 4136 | [#5] yui.html Cycles:180 Average:22770.41 Median:4031.26 stddev:33866.17 (840.1%) stddev-sans-first:33921.01 07:33:35 INFO - PROCESS | 4136 | Values: 802.4 806.3 814.5 820.4 924.5 15710.4 16716.6 16791.7 16892.5 16923.8 15180.2 15226.3 15233.7 15250.1 15318.6 723.0 836.6 860.7 883.1 883.5 886.3 891.0 893.2 895.1 899.2 940.4 941.4 941.7 942.6 943.1 935.0 935.1 938.4 938.7 940.7 687.2 691.4 691.6 692.0 697.2 14886.1 14899.3 14903.9 14929.1 14940.6 15902.4 16767.2 16860.2 17123.1 17235.9 13145.2 13234.7 13304.3 13382.4 13388.5 3965.4 4021.9 4040.6 4058.5 4101.8 88221.0 88424.6 88473.6 88973.0 89092.0 12454.8 13130.5 13377.7 13425.6 13547.4 25972.2 26093.7 26337.6 26514.3 26965.6 8886.6 9208.9 9340.2 9406.4 9441.8 5009.8 5089.5 5156.7 5288.9 5477.7 3544.4 3661.8 3668.0 3695.0 3720.3 625.7 629.2 690.5 716.9 728.4 640.1 789.9 840.6 851.3 858.0 9458.8 9831.6 10308.9 10480.7 10520.6 770.5 783.7 794.0 801.8 809.9 5027.3 5242.5 5279.2 5375.7 5389.5 131362.0 134005.0 134349.0 135368.3 139687.0 114112.0 116925.0 118803.0 120700.0 125127.0 88711.6 94954.5 96850.0 98637.5 103661.0 9291.5 9813.7 9865.7 9903.8 9906.7 48560.3 49863.5 61857.7 62101.7 63147.7 49906.8 52325.7 53696.7 53831.7 62226.0 14452.8 14475.7 14695.3 14743.9 14821.0 14694.8 14885.7 15215.1 15397.9 15524.4 14776.5 15010.7 15679.2 15719.1 15876.4 13511.5 13883.6 14261.6 14380.6 14553.4 13259.6 14294.9 14443.9 15346.6 15533.5 11769.2 12008.5 12363.3 12390.6 12727.8 11548.0 11616.4 11709.3 11816.4 11878.6 07:33:35 INFO - PROCESS | 4136 | -------- Summary: end -------- 07:33:35 INFO - PROCESS | 4136 | 07:33:36 INFO - TEST-INFO | 4136: exit 0 07:33:36 INFO - TEST-OK | dromaeo_css | took 1111133ms 07:33:36 INFO - TEST-START | kraken 07:33:36 INFO - operating with platform_type : linux_ 07:33:36 INFO - Initialising browser for kraken test... 07:33:36 INFO - TEST-INFO | started process 4409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO55LM0/profile http://localhost:48359/getInfo.html) 07:33:41 INFO - PROCESS | 4409 | __metrics Screen width/height:1600/1200 07:33:41 INFO - PROCESS | 4409 | colorDepth:24 07:33:41 INFO - PROCESS | 4409 | Browser inner width/height: 1024/697 07:33:41 INFO - PROCESS | 4409 | __metrics 07:33:41 ERROR - PROCESS | 4409 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 07:33:42 INFO - TEST-INFO | 4409: exit 0 07:33:42 INFO - Browser initialized. 07:33:42 INFO - Running cycle 1/1 for kraken test... 07:33:42 INFO - TEST-INFO | started process 4533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO55LM0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:54 INFO - PROCESS | 4533 | RSS: Main: 152535040 07:33:54 INFO - PROCESS | 4533 | 07:33:57 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48359/tests/kraken/driver.html?testName=audio-beat-detection) 07:33:57 INFO - PROCESS | 4533 | RSS: Main: 158318592 07:33:57 INFO - PROCESS | 4533 | 07:34:00 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48359/tests/kraken/driver.html?testName=audio-dft) 07:34:01 INFO - PROCESS | 4533 | RSS: Main: 156700672 07:34:01 INFO - PROCESS | 4533 | 07:34:04 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48359/tests/kraken/driver.html?testName=audio-fft) 07:34:04 INFO - PROCESS | 4533 | RSS: Main: 157200384 07:34:04 INFO - PROCESS | 4533 | 07:34:06 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48359/tests/kraken/driver.html?testName=audio-oscillator) 07:34:07 INFO - PROCESS | 4533 | RSS: Main: 157155328 07:34:07 INFO - PROCESS | 4533 | 07:34:09 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:10 INFO - PROCESS | 4533 | RSS: Main: 157110272 07:34:10 INFO - PROCESS | 4533 | 07:34:13 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48359/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:13 INFO - PROCESS | 4533 | RSS: Main: 156479488 07:34:13 INFO - PROCESS | 4533 | 07:34:17 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48359/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:17 INFO - PROCESS | 4533 | RSS: Main: 158314496 07:34:17 INFO - PROCESS | 4533 | 07:34:20 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48359/tests/kraken/driver.html?testName=json-parse-financial) 07:34:21 INFO - PROCESS | 4533 | RSS: Main: 157503488 07:34:21 INFO - PROCESS | 4533 | 07:34:22 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:23 INFO - PROCESS | 4533 | RSS: Main: 157323264 07:34:23 INFO - PROCESS | 4533 | 07:34:25 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:26 INFO - PROCESS | 4533 | RSS: Main: 157229056 07:34:26 INFO - PROCESS | 4533 | 07:34:28 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:28 INFO - PROCESS | 4533 | RSS: Main: 157609984 07:34:28 INFO - PROCESS | 4533 | 07:34:31 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:31 INFO - PROCESS | 4533 | RSS: Main: 157564928 07:34:31 INFO - PROCESS | 4533 | 07:34:34 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:35 INFO - PROCESS | 4533 | RSS: Main: 157736960 07:34:35 INFO - PROCESS | 4533 | 07:34:36 INFO - PROCESS | 4533 | Cycle 1(1): loaded http://localhost:48359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48359/tests/kraken/driver.html?testName=ai-astar) 07:34:37 INFO - PROCESS | 4533 | RSS: Main: 158482432 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | __start_tp_report 07:34:37 INFO - PROCESS | 4533 | _x_x_mozilla_page_load 07:34:37 INFO - PROCESS | 4533 | _x_x_mozilla_page_load_details 07:34:37 INFO - PROCESS | 4533 | |i|pagename|runs| 07:34:37 INFO - PROCESS | 4533 | |0;ai-astar;100;113;106;113;112;112;112;112;111;111 07:34:37 INFO - PROCESS | 4533 | |1;audio-beat-detection;144;124;146;168;117;143;154;120;170;118 07:34:37 INFO - PROCESS | 4533 | |2;audio-dft;164;164;164;163;162;168;173;166;163;163 07:34:37 INFO - PROCESS | 4533 | |3;audio-fft;75;75;76;176;76;75;77;74;162;76 07:34:37 INFO - PROCESS | 4533 | |4;audio-oscillator;86;83;151;84;85;84;138;85;84;143 07:34:37 INFO - PROCESS | 4533 | |5;imaging-gaussian-blur;117;117;118;118;117;117;118;118;118;117 07:34:37 INFO - PROCESS | 4533 | |6;imaging-darkroom;146;147;148;146;147;146;148;147;147;147 07:34:37 INFO - PROCESS | 4533 | |7;imaging-desaturate;94;95;95;95;96;96;96;96;95;96 07:34:37 INFO - PROCESS | 4533 | |8;json-parse-financial;51;51;51;52;51;52;53;54;51;54 07:34:37 INFO - PROCESS | 4533 | |9;json-stringify-tinderbox;59;60;62;60;60;61;60;61;61;61 07:34:37 INFO - PROCESS | 4533 | |10;stanford-crypto-aes;76;73;74;72;73;74;78;79;77;73 07:34:37 INFO - PROCESS | 4533 | |11;stanford-crypto-ccm;126;122;119;123;129;124;123;118;162;118 07:34:37 INFO - PROCESS | 4533 | |12;stanford-crypto-pbkdf2;150;151;155;150;159;153;154;154;158;153 07:34:37 INFO - PROCESS | 4533 | |13;stanford-crypto-sha256-iterative;64;63;61;62;62;60;61;61;61;60 07:34:37 INFO - PROCESS | 4533 | __end_tp_report 07:34:37 INFO - PROCESS | 4533 | __start_cc_report 07:34:37 INFO - PROCESS | 4533 | _x_x_mozilla_cycle_collect,871 07:34:37 INFO - PROCESS | 4533 | __end_cc_report 07:34:37 INFO - PROCESS | 4533 | __startTimestamp1473258877025__endTimestamp 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | ------- Summary: start ------- 07:34:37 INFO - PROCESS | 4533 | Number of tests: 14 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:4.10 (3.7%) stddev-sans-first:2.12 07:34:37 INFO - PROCESS | 4533 | Values: 100.0 113.0 106.0 113.0 112.0 112.0 112.0 112.0 111.0 111.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:145.00 stddev:20.02 (13.8%) stddev-sans-first:21.20 07:34:37 INFO - PROCESS | 4533 | Values: 144.0 124.0 146.0 168.0 117.0 143.0 154.0 120.0 170.0 118.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:3.30 (2.0%) stddev-sans-first:3.48 07:34:37 INFO - PROCESS | 4533 | Values: 164.0 164.0 164.0 163.0 162.0 168.0 173.0 166.0 163.0 163.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.50 stddev:39.57 (52.4%) stddev-sans-first:41.36 07:34:37 INFO - PROCESS | 4533 | Values: 75.0 75.0 76.0 176.0 76.0 75.0 77.0 74.0 162.0 76.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:28.95 (34.5%) stddev-sans-first:30.10 07:34:37 INFO - PROCESS | 4533 | Values: 86.0 83.0 151.0 84.0 85.0 84.0 138.0 85.0 84.0 143.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:34:37 INFO - PROCESS | 4533 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:34:37 INFO - PROCESS | 4533 | Values: 146.0 147.0 148.0 146.0 147.0 146.0 148.0 147.0 147.0 147.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 07:34:37 INFO - PROCESS | 4533 | Values: 94.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.25 (2.4%) stddev-sans-first:1.27 07:34:37 INFO - PROCESS | 4533 | Values: 51.0 51.0 51.0 52.0 51.0 52.0 53.0 54.0 51.0 54.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.71 07:34:37 INFO - PROCESS | 4533 | Values: 59.0 60.0 62.0 60.0 60.0 61.0 60.0 61.0 61.0 61.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:2.42 (3.2%) stddev-sans-first:2.54 07:34:37 INFO - PROCESS | 4533 | Values: 76.0 73.0 74.0 72.0 73.0 74.0 78.0 79.0 77.0 73.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:123.50 stddev:12.99 (10.5%) stddev-sans-first:13.78 07:34:37 INFO - PROCESS | 4533 | Values: 126.0 122.0 119.0 123.0 129.0 124.0 123.0 118.0 162.0 118.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:154.00 stddev:3.06 (2.0%) stddev-sans-first:2.93 07:34:37 INFO - PROCESS | 4533 | Values: 150.0 151.0 155.0 150.0 159.0 153.0 154.0 154.0 158.0 153.0 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - PROCESS | 4533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.27 (2.1%) stddev-sans-first:0.97 07:34:37 INFO - PROCESS | 4533 | Values: 64.0 63.0 61.0 62.0 62.0 60.0 61.0 61.0 61.0 60.0 07:34:37 INFO - PROCESS | 4533 | -------- Summary: end -------- 07:34:37 INFO - PROCESS | 4533 | 07:34:37 INFO - TEST-INFO | 4533: exit 0 07:34:38 INFO - TEST-OK | kraken | took 61595ms 07:34:38 INFO - SUITE-END | took 1172s 07:34:38 INFO - Completed test suite (00:19:32) 07:34:38 INFO - javascript benchmark 07:34:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7769.019420871789, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.8690852365908, 3292.1111299949016, 3310.58617672791, 3312.420326442872, 3315.751318651102, 5682.119271512912, 5696.6866822324755, 5732.054211055176, 5752.884942301152, 5774.105013722869, 5664.291963504562, 5764.452377024187, 5796.304443466779, 5798.913016304748, 5804.709764511768, 5228.163493840977, 5254.21186821976, 5254.395744489375, 5305.442928492511, 5315.069862773999, 5182.196759502264, 5223.216517522383, 5229.895402091975, 5267.420583735786, 5305.4164041955355, 5248.895022099556, 5253.789848406059, 5262.973685131569, 5275.683458992473, 5334.51989320961, 5268.9473105269035, 5306.681599104066, 5313.256144139824, 5314.92027619586, 5341.118715411992, 4990.675606085593, 4992.725400102993, 5023.748812559357, 5224.425313215544, 5225.294585230983, 5505.972470137664, 5540.418256083093, 5547.861303467405, 5557.777688892439, 5614.747336369873, 5964.343922168558, 5967.343592204854, 5989.850253743648, 5997.490213331872, 6045.879082418327, 5864.442877926633, 5964.761409543613, 6001.189839371673, 6029.366916473795, 6033.607815491979, 5663.235463212413, 5666.405027472098, 5674.602777805555, 5681.346645135821, 5681.517071048966, 6174.9073763893575, 6183.412575805291, 6185.381461853779, 6195.19462469885, 6197.318294987548, 5844.649321040752, 5876.7355469004, 5906.5570082244, 5947.464728174398, 5975.611585246945, 6034.879302413927, 6045.969770151121, 6051.243594550681, 6075.848103797441, 6077.453029227391, 5971.223740913653, 6020.939790602038, 6024.789132380346, 6024.879502409927, 6057.697115144225, 5809.680467574324, 5924.170616113747, 5927.318358388754, 5962.0, 6054.212952316171, 4586.3579098926175, 4589.472210695746, 4605.792739326738, 4606.262997920317, 4614.653900957442, 4124.030852749602, 4130.339145736728, 4135.545090040093, 4138.937915931264, 4175.54069052404, 5774.2782152230975, 5777.422257774189, 5787.884242315215, 5792.710364481759, 5809.390014048548, 6135.987562052301, 6152.169457123231, 6152.692365381713, 6164.876702466016, 6184.81445556634, 5911.113332999998, 5939.524838012949, 5943.138244954457, 5951.1073338999495, 5951.732172052268, 5151.5621172200035, 5290.709011004432, 5305.1776974569, 5322.0, 5345.278387417727, 6409.583377080475, 6457.1282876811965, 6461.160049193575, 6470.2559205691, 6492.64290464029, 6218.440340369389, 6248.4064013918605, 6266.655333956493, 6269.749210031548, 6282.403171698681, 6126.578745377076, 6144.907826382697, 6169.598976066542, 6216.0, 6483.481321494363, 5983.401659833982, 5989.5507836913275, 5990.131430942576, 5990.9700451497465, 5991.64050156992, 6066.272047354346, 6066.636001839904, 6067.302260239952, 6069.2110025696375, 6088.238970128734, 5777.768889244551, 5931.258592675916, 6019.578629495893, 6038.215032045806, 6043.3050199227655, 6007.219061521974, 6071.089336599545, 6071.453569178795, 6075.1798507200965, 6091.451769340603, 5954.672493012926, 5962.9105563415715, 5986.371430999857, 6008.969955150196, 6017.488513476228, 5706.600537962303, 5793.971030144822, 5836.795712150054, 5839.211706419749, 6081.969590152021, 5753.827385178452, 5772.913406298825, 5775.624584402, 5791.073428251628, 5796.681182535001], "value": 5618.832018762267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.2503820148412, 627.8618703885144, 648.0732552449996, 665.2416245480152, 677.0, 40619.39070913935, 45590.772046139726, 45634.087318253616, 45669.314960275624, 45677.0, 45018.0, 45308.546914530845, 45356.0, 45508.0, 45521.317180242324, 8941.910580894206, 8968.192862642361, 9061.818763624724, 9071.365004449659, 9075.773105672379, 9015.413998090104, 9110.134537218953, 9119.042500537447, 9162.083791620818, 9171.724848254564, 9134.223590994774, 9163.312751543628, 9188.770280742969, 9194.678186263482, 9203.585838637244, 9103.817923641524, 9106.544672766368, 9109.225715814098, 9142.268618510536, 9171.954140229256, 8932.910670893272, 9013.594388252479, 9034.45793252407, 9038.638454461814, 9060.68287609937, 43235.56764432347, 43496.782516087536, 43546.346804797955, 43577.0, 43812.780936095114, 3725.6274372562525, 3770.566384865748, 3779.981100094509, 3832.2910261601414, 4076.0, 34681.30637387238, 34942.30115397703, 35075.64924350749, 35317.0, 35555.822220888986, 4480.529544397857, 4511.097780443892, 4543.136804007261, 4543.273076307808, 4618.607418369443, 347123.0, 350969.0, 351178.0, 353290.99999999744, 354016.0, 54602.0, 54606.45393546093, 54655.18017229745, 54835.72582137064, 54918.450815492135, 39234.60765392367, 39767.60232397697, 40414.59585404109, 41905.0, 42072.36891446631, 18008.549786255448, 18076.36732714375, 18109.0, 18142.909285453487, 18143.364982225823, 12349.259044457362, 12401.0, 12410.503579856886, 12440.75118497625, 12449.066320026035, 20591.176352945713, 20615.8969205153, 20832.79167208339, 20867.895660521903, 20905.790942090385, 7469.253074692488, 7488.588127653032, 7498.85002299951, 7611.619419029026, 7820.530768153815, 1014.183582216323, 1055.2771351624162, 1070.5610699613278, 1098.6429410441638, 1234.672811704899, 33742.662573374444, 34114.658853411645, 34316.313673726385, 34447.655523444446, 34903.4764478533, 1163.7207070303066, 1194.808830587102, 1235.8702336254744, 1246.2647038247296, 1264.9114561980757, 16895.241903238802, 17155.91422042882, 17400.303987840343, 17448.302067917142, 17609.207585658674, 578464.0, 579815.0, 583778.0, 584493.0, 585593.0, 61169.38830611726, 61507.0, 61519.38480615226, 61625.0, 61678.0, 1483.9851601483847, 1487.2043456750803, 1514.4245186829155, 1518.1953564610774, 1523.6419441431256, 31802.840985794923, 32291.51562726514, 32395.51406728948, 32698.83650581732, 33124.66875331216, 53208.20187697265, 53971.46028539664, 54283.0, 54329.456705432436, 54346.18480722872, 526363.0, 527901.0, 531193.0, 531824.0, 533250.0, 29772.255693607833, 30365.392692146474, 30394.696053039188, 30551.847240763655, 30565.54151687771, 50025.49974500208, 50255.74872125616, 50576.0, 50682.493175069256, 50760.23859642034, 42750.786246069816, 43230.0, 43749.0, 43904.56095439005, 44519.0, 43364.78317608392, 43394.349084764384, 43563.56436435722, 43759.0, 44068.77965610151, 37022.629773702996, 39967.80016099901, 40388.79805600953, 40518.59481405266, 41827.58172418358, 36801.63198367982, 38236.90146163081, 38250.617493824706, 38266.61733382742, 38372.808135959145, 28622.427551448436, 29288.853555732087, 29298.585256887563, 29318.0, 29517.557236641896], "value": 20847.3783836745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.474814108294, 420.8674267605702, 426.47117574207994, 426.5095140588323, 431.8121617096563, 19456.41630751078, 19880.801191988077, 21002.369928902157, 21107.788922110773, 21304.360869173932, 19239.326623568177, 19816.900915495404, 20052.59894802103, 20221.39335819928, 20572.0, 5301.098813201756, 5496.422875598065, 5500.80747173849, 5501.477359650827, 5501.559875209994, 5390.164524498709, 5462.754176062087, 5488.5609151268, 5569.331680198382, 5797.478226959573, 5895.941040589603, 5913.408659134096, 5954.612950158225, 5956.463918247357, 5968.552358573124, 5873.970630146843, 5938.7624495020145, 6207.410296021871, 6379.266384365811, 6380.234371875358, 6141.4472697456995, 6203.658798766066, 6206.689665516751, 6224.190855188842, 6249.78125765596, 14656.560303190921, 14820.0, 14888.702225955529, 23371.53256934869, 24490.387740306636, 2448.375664205616, 2724.7002829688718, 3088.722015018659, 3187.569678093451, 3233.5634689316876, 14301.642458938506, 15152.772708409382, 15220.315085821165, 15397.846021539754, 15487.612809679735, 2008.5279959209574, 2009.0141686795018, 2039.7960203979633, 2088.091680119153, 2113.6829475578634, 87527.0, 88504.0, 89210.5539472305, 89980.0, 90663.0, 11011.83482247767, 11344.48949797261, 11797.941010294893, 11984.161108722481, 12251.387430628432, 16916.915415422845, 16944.0, 17073.7438938416, 17082.0, 17097.230624621923, 8239.217274358927, 8255.133211012877, 8449.493030418194, 8676.479411235347, 8828.690995815115, 7561.281678240558, 7627.580483073484, 7629.351505122016, 7690.884636730453, 7787.571683557346, 4981.676191047571, 4990.575801056878, 5029.899402012013, 5051.823186188466, 5245.816396426107, 2092.872462466962, 2147.2591955775233, 2170.934871953844, 2175.564887022602, 2191.29878438898, 969.5103972493846, 1058.327961744298, 1085.6417382263835, 1145.6391236760394, 1177.370106992772, 21043.47391315199, 21122.682296087012, 21132.732036077883, 21162.576748465253, 21444.463888402915, 1026.9691909242736, 1033.4884232305058, 1038.2420832792104, 1040.3549799124592, 1095.0746619106842, 11355.716107097389, 11740.473738414123, 11944.343061131547, 11985.460654270404, 12038.277703337828, 472936.0, 482836.0, 493302.0, 519966.0, 527711.0, 95992.52003740077, 96148.0, 96896.51551742195, 97150.0, 100021.0, 1052.9894701052892, 1068.9625863094755, 1070.6359837655234, 1074.1299547366657, 1086.4241951765578, 15757.763633545736, 17400.129993500526, 17975.460736177934, 18536.721949170504, 18994.050297485348, 41679.374809377274, 42277.0, 42337.0, 42645.14709705851, 42756.1448771029, 57512.0, 59260.70369648297, 59879.401205989125, 59916.40083599108, 61858.38141618706, 9143.542822858963, 9147.77130571741, 9181.495017774087, 9221.400608960395, 9238.538073096453, 10106.932908465218, 14237.786433203717, 14404.927975360057, 14496.275186240857, 14703.0, 11647.0, 11666.824997624874, 11729.178957473236, 11745.823812642988, 12489.93755031219, 11684.357360344922, 11983.880161198626, 12087.335196564274, 12145.757084858076, 12306.815397768862, 11808.0, 11921.225120367495, 12219.327936963553, 12309.56916507918, 12318.199317044364, 8930.687425940061, 8986.595603198002, 9130.178283954476, 9216.493092879957, 9341.906580934103, 11496.655100347003, 11955.402229888645, 12134.0, 12210.450529726006, 12527.248365098123], "value": 9749.148257932591, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1560.5552417560993, 1578.4080969636386, 1785.6517978994093, 1866.6266746650674, 1880.9341673041447, 8059.516429014263, 9036.141566551183, 9369.765755856099, 10104.545295461703, 10116.74708132297, 9476.81046379072, 9866.0, 9867.0, 9871.210303175747, 9877.60489580416, 2438.5122975404947, 2461.59383701689, 2474.2453551666736, 2479.7024357077175, 2484.3043947694673, 2375.192434572245, 2489.390099425634, 2507.2227609441134, 2507.8244522883406, 2508.2224510401834, 2304.562133194696, 2307.976920230793, 2313.6182529882635, 2318.6058370077044, 2324.0936034946385, 2387.7254115776645, 2389.4623709665275, 2390.3904504351367, 2397.568437681217, 2420.9273721788372, 2295.024614538831, 2326.592846251916, 2359.7522260162777, 2369.0, 2370.2059809963685, 9397.436153830724, 9514.28642851789, 9515.666951656658, 9598.424094554279, 9604.855927161097, 5574.86062848428, 5641.238432811559, 5716.314042314949, 5723.742431590588, 5733.512651424634, 3470.826458677056, 3547.2018795770746, 3591.299696559172, 3604.5494313210847, 3635.2729454109285, 1161.7386088130188, 1211.0493262788668, 1221.1567648800446, 1230.1266101068252, 1230.772307123185, 13838.861611383958, 13862.306884655727, 13897.0966887152, 13914.791278130837, 14013.299335033309, 4729.498987879344, 4786.880327991758, 4790.4251489821445, 4908.509149085135, 4916.360873086476, 11012.559497620166, 11023.0, 11041.889581104086, 11051.944740276247, 11056.060234880126, 5641.26663533738, 5734.799282025109, 5740.454656807597, 5766.740496677659, 5769.740361683735, 4365.3670217818235, 5146.382434107856, 5177.0940085485645, 5239.895202096013, 5391.4608539145775, 3963.5243770747693, 4019.959800402017, 4061.086255592468, 4074.714769966074, 4105.281575724236, 1169.6081812592877, 1204.6988252936767, 1209.8245754365569, 1210.9939450302868, 1222.0834374219335, 1044.5090807320548, 1053.7787064716342, 1068.8877667844765, 1070.5824728355947, 1080.621782376162, 6207.751689932352, 6507.0, 6614.0, 6629.9337006630285, 6839.93160068393, 1029.5264178477835, 1034.4930983818026, 1063.8936106389299, 1076.8277075667856, 1088.1349327284827, 4447.955520444819, 4455.532169122195, 4460.799264033127, 4496.3255511673515, 4562.566556177224, 12335.568255111028, 12347.259164450163, 12624.684382890318, 12702.364881755875, 12830.679233019062, 12566.937165314115, 12632.621021369374, 12732.936335318263, 12743.0, 12744.936275318563, 8985.0, 9063.184313411824, 9266.44401335922, 9391.953040234892, 9415.105564971316, 6682.83292917681, 6752.696128674123, 6762.120924279812, 6782.389584937379, 6857.348551887562, 11463.0, 11659.067274618179, 11709.473073711533, 11721.296722196696, 11735.941320293345, 11598.304101753922, 11621.418929053345, 11919.582814601446, 11932.701682458008, 11944.04447644169, 8094.352451803724, 8249.711260105867, 8250.711225107092, 8363.665453381796, 8404.915950840414, 9420.62317507292, 9641.758956026155, 9701.466419347003, 9722.611095556098, 9739.561719722771, 8742.82514349722, 8786.077461866667, 8818.162274583905, 8942.418742781698, 8956.104389560991, 8504.107068757692, 8581.184787445183, 8611.0, 8690.522021288889, 8767.780805479659, 7551.056117985252, 7678.308952194329, 7690.961545192238, 7697.114831794192, 7698.653560589899, 5757.884842303214, 5821.330546986981, 5825.300963884361, 5865.677387743715, 5902.61632993854, 5430.592705547021, 5437.510624043855, 5524.613277070566, 5535.114381698909, 5569.220309156803], "value": 5051.333310377065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.35587849268654, 348.30339321357286, 353.05205523170275, 353.2370080625849, 355.6461320985618, 5740.253767010288, 5815.912761308578, 5862.912056319158, 5873.735681894314, 5925.4963328117165, 5662.150677398392, 5714.428557144283, 5721.7711291548285, 5763.049096899007, 5805.883882322351, 4440.356148358486, 4573.9085218295695, 4599.8390056348035, 4613.2388155954395, 4621.630269578425, 4568.497465278817, 4573.885652858672, 4582.633389328862, 4598.839040633578, 4609.193391156551, 4512.864614061584, 4561.521040290755, 4581.954180458203, 4592.196365636017, 4617.376654151697, 4433.778311084465, 4538.410006699141, 4549.795259213327, 4557.74932378719, 4562.4753153387455, 4037.777922214277, 4059.3099173140636, 4060.796960151981, 4070.1656160487028, 4081.7142600081174, 5686.175504551817, 5712.714364281769, 5730.656160630376, 5736.483716465496, 5736.971315143439, 5081.8729531762, 5242.97378513105, 5260.132078207092, 5271.42014378418, 5306.09796334624, 6119.877602447926, 6147.508199344042, 6154.138420621117, 6164.229471316085, 6165.568410211287, 4497.797599108048, 4504.842330518416, 4508.887277818048, 4511.150428324404, 4511.278195488706, 6207.565470417073, 6323.0, 6339.144215530937, 6410.679466026727, 6413.262474815409, 4547.067851090585, 4579.564941330568, 4593.977030114895, 4609.631229501631, 4621.976890115595, 4643.628509719214, 4647.070585882837, 4650.581447669659, 4654.115718013634, 4673.182193116191, 4972.303877457159, 5223.451537588575, 5232.136697444955, 5275.736213189325, 5314.388845282765, 6072.330109219912, 6076.389756714474, 6119.684267882427, 6125.142480052797, 6133.539984501091, 1574.7559128334897, 1588.6663800601773, 1617.2964760329294, 1619.9757003644954, 1623.091069001363, 1010.1666125446536, 1012.8683271174848, 1012.9139023182964, 1013.8580598716186, 1037.9896201037893, 5270.285802811555, 5275.709835959059, 5287.836675931289, 5290.68255904647, 5307.734613269321, 5402.783888644489, 5485.6434331768305, 5490.72135063952, 5585.636933599384, 5591.217229587861, 5353.153162159049, 5602.97198514013, 6015.699215039231, 6031.215941927521, 6034.24571928509, 3333.466645336783, 3346.380919529895, 3380.7295416366633, 3391.898243052663, 3396.3886500429667, 6324.494040476751, 6471.805845824539, 6492.0, 6602.14172157626, 6618.569792963538, 6123.091531522491, 6310.4636105930595, 6389.808305750835, 6396.569303664671, 6439.549231553746, 6410.711517981702, 6529.869402611921, 6568.671566421755, 6570.8357291068105, 6624.635645039569, 6257.874842503215, 6287.937120628735, 6327.766085613262, 6337.334579869047, 6356.745730170926, 6060.636361818305, 6144.201253836973, 6183.093945845446, 6228.813135605939, 6259.499240060693, 6450.29067297176, 6524.836879078061, 6544.574602651003, 6551.60690358561, 6602.933970660232, 4304.504981927118, 4385.978070109629, 4387.451568553931, 4410.757408342572, 4437.445319335083, 6242.094896239929, 6255.529950461547, 6287.830698409041, 6316.842078948063, 6322.905156422566, 5965.970170149121, 6157.507399407947, 6214.768320473238, 6225.657588832658, 6229.3770622937345, 6011.0, 6086.665233412028, 6101.60339577926, 6123.326434092335, 6128.32588415265, 6044.153818465506, 6098.146259523582, 6100.115483254992, 6101.908471373022, 6131.509479241739, 5947.197128387786, 6044.818655440344, 6106.45041946227, 6137.355577664281, 6237.625742455467, 5921.4966727826895, 5954.10688396744, 5972.820815375546, 6000.76984218243, 6021.2904193114155], "value": 4651.81705423049, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.386174576449, 806.2904643913357, 814.4950130918832, 820.380612637459, 924.5192499900048, 15710.371585136596, 16716.582085447855, 16791.66416671666, 16892.493225203234, 16923.830761692396, 15180.165090919994, 15226.314815833286, 15233.695326093499, 15250.084994900313, 15318.617034574141, 722.9963850180768, 836.619338201117, 860.6858496648741, 883.0507204754882, 883.5052370672412, 886.2644005475472, 891.01542795211, 893.2139717048988, 895.1093661806511, 899.2221728205121, 940.3981451870808, 941.4163218804351, 941.7221919533754, 942.575840871607, 943.0899182289089, 934.9672761453351, 935.1209862729013, 938.4088024544527, 938.6714649872524, 940.6989763275755, 687.2028447001454, 691.3881215124601, 691.6472598974509, 692.0207905813268, 697.1947400752089, 14886.10683359002, 14899.255037248095, 14903.850961490463, 14929.10425374481, 14940.62648433787, 15902.363905443768, 16767.161641917854, 16860.241289142017, 17123.058231797248, 17235.91382043082, 13145.211287322696, 13234.73530529384, 13304.334783260894, 13382.397792099282, 13388.464461421532, 3965.405189221611, 4021.9360232498043, 4040.575739547364, 4058.472398588194, 4101.774402407867, 88220.99999999936, 88424.55787721084, 88473.55763221208, 88973.0, 89092.0, 12454.750904982031, 13130.540431084866, 13377.665558360924, 13425.597232083053, 13547.390367433489, 25972.220833375028, 26093.73906260951, 26337.604935925978, 26514.337141571614, 26965.595516067275, 8886.644534218558, 9208.861867071999, 9340.206082483064, 9406.43561386319, 9441.76395590102, 5009.849704508798, 5089.491050894955, 5156.690598564098, 5288.867778305496, 5477.726113694379, 3544.3620148373025, 3661.8169091545315, 3667.9633203668154, 3695.0392897846214, 3720.3489389357296, 625.6652690810395, 629.222909706512, 690.492488021304, 716.874546954281, 728.4318231779221, 640.1262276991872, 789.9328557072713, 840.609116760697, 851.3104385447807, 858.0, 9458.810823783486, 9831.557579908922, 10308.896911030793, 10480.68557943263, 10520.631777887736, 770.4722265248323, 783.7178615698344, 793.9801504962306, 801.7640791853569, 809.8501777171242, 5027.321311622884, 5242.52817246442, 5279.234510995961, 5375.6774593524515, 5389.487998640123, 131362.0, 134005.0, 134349.0, 135368.32315838357, 139687.0, 114112.0, 116925.0, 118803.0, 120700.0, 125127.0, 88711.55644221867, 94954.52522737342, 96850.0, 98637.50681246692, 103661.0, 9291.535423228946, 9813.705588832347, 9865.704028879145, 9903.752406189902, 9906.653267135616, 48560.271595925384, 49863.501364987336, 61857.690711547955, 62101.68949155225, 63147.6842615784, 49906.75046624744, 52325.7383713079, 53696.731516342166, 53831.73084134554, 62226.0, 14452.783208251674, 14475.710485790436, 14695.265236738334, 14743.852561474678, 14821.0, 14694.77957830612, 14885.702285954438, 15215.08709477435, 15397.923010384877, 15524.37902483888, 14776.48282310114, 15010.699786004438, 15679.216039198223, 15719.135447550494, 15876.364945402054, 13511.459541618226, 13883.583492495241, 14261.64345891361, 14380.56858294253, 14553.417863285349, 13259.602211933658, 14294.928525357307, 14443.927780361031, 15346.616334591725, 15533.533993980198, 11769.17615766888, 12008.519659213534, 12363.32001739913, 12390.602493418837, 12727.809082863949, 11548.0, 11616.361100139573, 11709.297442153498, 11816.350100744541, 11878.584249551224], "value": 8193.412473210084, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 106.0, 113.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 146.0, 168.0, 117.0, 143.0, 154.0, 120.0, 170.0, 118.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 163.0, 162.0, 168.0, 173.0, 166.0, 163.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 176.0, 76.0, 75.0, 77.0, 74.0, 162.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 151.0, 84.0, 85.0, 84.0, 138.0, 85.0, 84.0, 143.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 52.0, 51.0, 52.0, 53.0, 54.0, 51.0, 54.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 62.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 72.0, 73.0, 74.0, 78.0, 79.0, 77.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 119.0, 123.0, 129.0, 124.0, 123.0, 118.0, 162.0, 118.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 155.0, 150.0, 159.0, 153.0, 154.0, 154.0, 158.0, 153.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 61.0, 62.0, 62.0, 60.0, 61.0, 61.0, 61.0, 60.0], "value": 61.5, "unit": "score"}]}]} 07:34:38 INFO - Return code: 0 07:34:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:34:38 ERROR - # TBPL SUCCESS # 07:34:38 INFO - Running post-action listener: _resource_record_post_action 07:34:38 INFO - [mozharness: 2016-09-07 14:34:38.334780Z] Finished run-tests step (success) 07:34:38 INFO - Running post-run listener: _resource_record_post_run 07:34:38 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 737280; Write bytes: 326471680; Read time: 496; Write time: 436280 07:34:38 INFO - TinderboxPrint: CPU usage
13.3% 07:34:38 INFO - TinderboxPrint: I/O read bytes / time
737,280 / 496 07:34:38 INFO - TinderboxPrint: I/O write bytes / time
326,471,680 / 436,280 07:34:38 INFO - TinderboxPrint: CPU idle
8,227.6 (86.7%) 07:34:38 INFO - TinderboxPrint: CPU user
1,201.1 (12.7%) 07:34:38 INFO - TinderboxPrint: Swap in / out
0 / 0 07:34:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78446592; Read time: 0; Write time: 131640 07:34:38 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 733184; Write bytes: 247050240; Read time: 480; Write time: 304596 07:34:38 INFO - Running post-run listener: _upload_blobber_files 07:34:38 INFO - Blob upload gear active. 07:34:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:38 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 07:34:38 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'] 07:34:38 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 07:34:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:42 INFO - (blobuploader) - INFO - Done attempting. 07:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:43 INFO - (blobuploader) - INFO - Done attempting. 07:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:44 INFO - (blobuploader) - INFO - Done attempting. 07:34:44 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:44 INFO - Return code: 0 07:34:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081b3a87562015dfdd1967c9433ccfb461d73cbd50585262a50016d855095a02ca430630217595bae331bc99e10f7e850e6bdbd2fe46676759ada3ef30b2dc12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ab88419da32809d15e891255e510a065dee7c7cb1bfa22eb4499bc95dc4bdbb5a19ebd8cffd955c35aaba67f9d7f6bb35d79f071c77bb603c4d7e10fb20046b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1019f156e71f23465876fae5960de95c5a1239d6f759867518d7c28c87897c3cd331f3374dfcce2d61e06c08567b8b5a9ab25a8d0f9916c5a8df20abf28d47c"} 07:34:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:44 INFO - Contents: 07:34:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/081b3a87562015dfdd1967c9433ccfb461d73cbd50585262a50016d855095a02ca430630217595bae331bc99e10f7e850e6bdbd2fe46676759ada3ef30b2dc12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ab88419da32809d15e891255e510a065dee7c7cb1bfa22eb4499bc95dc4bdbb5a19ebd8cffd955c35aaba67f9d7f6bb35d79f071c77bb603c4d7e10fb20046b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1019f156e71f23465876fae5960de95c5a1239d6f759867518d7c28c87897c3cd331f3374dfcce2d61e06c08567b8b5a9ab25a8d0f9916c5a8df20abf28d47c"} 07:34:44 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:44 INFO - Copying logs to upload dir... 07:34:44 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.303679 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-07 07:34:44.445432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 07:34:44.449584) ========= 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=5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038 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/081b3a87562015dfdd1967c9433ccfb461d73cbd50585262a50016d855095a02ca430630217595bae331bc99e10f7e850e6bdbd2fe46676759ada3ef30b2dc12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ab88419da32809d15e891255e510a065dee7c7cb1bfa22eb4499bc95dc4bdbb5a19ebd8cffd955c35aaba67f9d7f6bb35d79f071c77bb603c4d7e10fb20046b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1019f156e71f23465876fae5960de95c5a1239d6f759867518d7c28c87897c3cd331f3374dfcce2d61e06c08567b8b5a9ab25a8d0f9916c5a8df20abf28d47c"} build_url:https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/NGXq8ju_TMm4i5UGKYKdWQ/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/081b3a87562015dfdd1967c9433ccfb461d73cbd50585262a50016d855095a02ca430630217595bae331bc99e10f7e850e6bdbd2fe46676759ada3ef30b2dc12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ab88419da32809d15e891255e510a065dee7c7cb1bfa22eb4499bc95dc4bdbb5a19ebd8cffd955c35aaba67f9d7f6bb35d79f071c77bb603c4d7e10fb20046b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1019f156e71f23465876fae5960de95c5a1239d6f759867518d7c28c87897c3cd331f3374dfcce2d61e06c08567b8b5a9ab25a8d0f9916c5a8df20abf28d47c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 07:34:44.479066) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:34:44.479468) ========= 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=5bd038846534b2fdfa68eeae000001e2-1473256930.910404-1995131038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 07:34:44.567571) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 07:34:44.567935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 07:34:44.568278) ========= ========= Total master_lag: 0.19 =========