builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1473824946.49 results: success (0) buildid: 20160913190821 builduid: 4962b209c9f24a55bcb93a87a049fc35 revision: 3c621f8c782957aeda376304afe884139b7ee49a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.489463) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.489953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.490289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.505225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.505557) ========= 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=fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-13 20:49:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-09-13 20:49:07 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.591005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.591315) ========= 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=fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.640072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:06.640379) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c621f8c782957aeda376304afe884139b7ee49a --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 3c621f8c782957aeda376304afe884139b7ee49a --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=fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-13 20:49:07,129 truncating revision to first 12 chars 2016-09-13 20:49:07,129 Setting DEBUG logging. 2016-09-13 20:49:07,129 attempt 1/10 2016-09-13 20:49:07,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c621f8c7829?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 20:49:07,560 unpacking tar archive at: mozilla-aurora-3c621f8c7829/testing/mozharness/ program finished with exit code 0 elapsedTime=0.757368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:07.411423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:07.411779) ========= script_repo_revision: 3c621f8c782957aeda376304afe884139b7ee49a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:07.412220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:07.412495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 20:49:07.423388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-13 20:49:07.423683) ========= /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=fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:49:07 INFO - MultiFileLogger online at 20160913 20:49:07 in /builds/slave/test 20:49:07 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 20:49:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:49:08 INFO - {'append_to_log': False, 20:49:08 INFO - 'base_work_dir': '/builds/slave/test', 20:49:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:49:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:49:08 INFO - 'branch': 'Mozilla-Aurora', 20:49:08 INFO - 'buildbot_json_path': 'buildprops.json', 20:49:08 INFO - 'config_files': ('talos/linux_config.py',), 20:49:08 INFO - 'default_actions': ('clobber', 20:49:08 INFO - 'read-buildbot-config', 20:49:08 INFO - 'download-and-extract', 20:49:08 INFO - 'populate-webroot', 20:49:08 INFO - 'create-virtualenv', 20:49:08 INFO - 'install', 20:49:08 INFO - 'run-tests'), 20:49:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:49:08 INFO - 'download_minidump_stackwalk': True, 20:49:08 INFO - 'download_symbols': 'ondemand', 20:49:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:49:08 INFO - 'tooltool.py': '/tools/tooltool.py', 20:49:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:49:08 INFO - '/tools/misc-python/virtualenv.py')}, 20:49:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:49:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:49:08 INFO - 'installer_path': 'installer.exe', 20:49:08 INFO - 'log_level': 'info', 20:49:08 INFO - 'log_name': 'talos', 20:49:08 INFO - 'log_to_console': True, 20:49:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:49:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:49:08 INFO - 'opt_config_files': (), 20:49:08 INFO - 'pip_index': False, 20:49:08 INFO - 'sps_profile': False, 20:49:08 INFO - 'sps_profile_interval': 0, 20:49:08 INFO - 'suite': 'dromaeojs-e10s', 20:49:08 INFO - 'system_bits': '32', 20:49:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:49:08 INFO - 'title': 'talos-linux64-ix-048', 20:49:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:49:08 INFO - 'use_talos_json': True, 20:49:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:49:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:49:08 INFO - 'work_dir': 'build'} 20:49:08 INFO - [mozharness: 2016-09-14 03:49:08.006688Z] Running clobber step. 20:49:08 INFO - Running pre-action listener: _resource_record_pre_action 20:49:08 INFO - Running main action method: clobber 20:49:08 INFO - rmtree: /builds/slave/test/build 20:49:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:49:08 INFO - Running post-action listener: _resource_record_post_action 20:49:08 INFO - [mozharness: 2016-09-14 03:49:08.980463Z] Finished clobber step (success) 20:49:08 INFO - [mozharness: 2016-09-14 03:49:08.980564Z] Running read-buildbot-config step. 20:49:08 INFO - Running pre-action listener: _resource_record_pre_action 20:49:08 INFO - Running main action method: read_buildbot_config 20:49:08 INFO - Using buildbot properties: 20:49:08 INFO - { 20:49:08 INFO - "project": "", 20:49:08 INFO - "product": "firefox", 20:49:08 INFO - "script_repo_revision": "production", 20:49:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:49:08 INFO - "repository": "", 20:49:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:49:08 INFO - "buildid": "20160913190821", 20:49:08 INFO - "pgo_build": "True", 20:49:08 INFO - "basedir": "/builds/slave/test", 20:49:08 INFO - "buildnumber": 551, 20:49:08 INFO - "slavename": "talos-linux64-ix-048", 20:49:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:49:08 INFO - "platform": "ubuntu64_hw", 20:49:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:49:08 INFO - "branch": "mozilla-aurora", 20:49:08 INFO - "repo_path": "releases/mozilla-aurora", 20:49:08 INFO - "revision": "3c621f8c782957aeda376304afe884139b7ee49a", 20:49:08 INFO - "stage_platform": "linux64-pgo", 20:49:08 INFO - "builduid": "4962b209c9f24a55bcb93a87a049fc35", 20:49:08 INFO - "slavebuilddir": "test" 20:49:08 INFO - } 20:49:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 20:49:08 INFO - Running post-action listener: _resource_record_post_action 20:49:08 INFO - [mozharness: 2016-09-14 03:49:08.983243Z] Finished read-buildbot-config step (success) 20:49:08 INFO - [mozharness: 2016-09-14 03:49:08.983330Z] Running download-and-extract step. 20:49:08 INFO - Running pre-action listener: _resource_record_pre_action 20:49:08 INFO - Running main action method: download_and_extract 20:49:08 INFO - mkdir: /builds/slave/test/build/tests 20:49:08 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')]} 20:49:08 INFO - https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:49:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:49:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:49:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:49:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:49:08 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:49:08 INFO - retry: Failed, sleeping 30 seconds before retrying 20:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:49:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:49:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:49:39 INFO - retry: Failed, sleeping 60 seconds before retrying 20:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:50:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:50:39 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:50:39 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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! 20:50:39 INFO - Caught exception: HTTP Error 404: Not Found 20:50:39 INFO - Caught exception: HTTP Error 404: Not Found 20:50:39 INFO - Caught exception: HTTP Error 404: Not Found 20:50:39 INFO - trying https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:50:39 INFO - Downloading https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:50:39 INFO - Downloaded 1361 bytes. 20:50:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:50:39 INFO - Using the following test package requirements: 20:50:39 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:50:39 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:50:39 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:50:39 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'jsshell-linux-x86_64.zip'], 20:50:39 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:50:39 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:50:39 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:50:39 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:50:39 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:50:39 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:50:39 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:50:39 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:50:39 INFO - https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:50:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:50:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:50:39 INFO - retry: Failed, sleeping 30 seconds before retrying 20:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:51:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:51:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:51:09 INFO - retry: Failed, sleeping 60 seconds before retrying 20:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:52:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:52:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:52:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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! 20:52:09 INFO - Caught exception: HTTP Error 404: Not Found 20:52:09 INFO - Caught exception: HTTP Error 404: Not Found 20:52:09 INFO - Caught exception: HTTP Error 404: Not Found 20:52:09 INFO - trying https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:52:09 INFO - Downloading https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:52:10 INFO - Downloaded 21771527 bytes. 20:52:10 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'] 20:52:10 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 20:52:11 INFO - Return code: 0 20:52:11 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 20:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:52:11 INFO - https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:52:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:52:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:52:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:52:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:52:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:52:11 INFO - retry: Failed, sleeping 30 seconds before retrying 20:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:52:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:52:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:52:41 INFO - retry: Failed, sleeping 60 seconds before retrying 20:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:53:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:53:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:53:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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! 20:53:41 INFO - Caught exception: HTTP Error 404: Not Found 20:53:41 INFO - Caught exception: HTTP Error 404: Not Found 20:53:41 INFO - Caught exception: HTTP Error 404: Not Found 20:53:41 INFO - trying https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:53:41 INFO - Downloading https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:53:42 INFO - Downloaded 21771527 bytes. 20:53:42 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'] 20:53:42 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 20:53:44 INFO - Return code: 0 20:53: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')]} 20:53:44 INFO - https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:53:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:53:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:53:44 INFO - retry: Failed, sleeping 30 seconds before retrying 20:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:54:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:54:14 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:54:14 INFO - retry: Failed, sleeping 60 seconds before retrying 20:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:55:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:55:14 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:55:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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! 20:55:14 INFO - Caught exception: HTTP Error 404: Not Found 20:55:14 INFO - Caught exception: HTTP Error 404: Not Found 20:55:14 INFO - Caught exception: HTTP Error 404: Not Found 20:55:14 INFO - trying https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:55:14 INFO - Downloading https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:55:14 INFO - Downloaded 14413740 bytes. 20:55:14 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'] 20:55:14 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 20:55:15 INFO - Return code: 0 20:55:15 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')]} 20:55:15 INFO - https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:55:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:55:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:55:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:55:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:55:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:55:15 INFO - retry: Failed, sleeping 30 seconds before retrying 20:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:55:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:55:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:55:45 INFO - retry: Failed, sleeping 60 seconds before retrying 20:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:56:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:56:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:56:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R67rPubpTzecr7S6UKp9Eg/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! 20:56:45 INFO - Caught exception: HTTP Error 404: Not Found 20:56:45 INFO - Caught exception: HTTP Error 404: Not Found 20:56:45 INFO - Caught exception: HTTP Error 404: Not Found 20:56:45 INFO - trying https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:56:45 INFO - Downloading https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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 20:56:46 INFO - Downloaded 63913472 bytes. 20:56:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:56:46 INFO - mkdir: /builds/slave/test/properties 20:56:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:56:46 INFO - Writing to file /builds/slave/test/properties/build_url 20:56:46 INFO - Contents: 20:56:46 INFO - build_url:https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:56:47 INFO - Running post-action listener: _resource_record_post_action 20:56:47 INFO - Running post-action listener: set_extra_try_arguments 20:56:47 INFO - [mozharness: 2016-09-14 03:56:47.245307Z] Finished download-and-extract step (success) 20:56:47 INFO - [mozharness: 2016-09-14 03:56:47.245580Z] Running populate-webroot step. 20:56:47 INFO - Running pre-action listener: _resource_record_pre_action 20:56:47 INFO - Running main action method: populate_webroot 20:56:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:56:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:56:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:56:47 INFO - '--tppagecycles', 20:56:47 INFO - '7'], 20:56:47 INFO - 'tests': ['tsvgm']}}, 20:56:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:56:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:56:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:56:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:56:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['damp', 'tps']}, 20:56:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'tests': ['damp', 'tps']}, 20:56:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['dromaeo_dom']}, 20:56:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:56:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['basic_compositor_video']}, 20:56:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:56:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['a11yr', 20:56:47 INFO - 'ts_paint', 20:56:47 INFO - 'tpaint', 20:56:47 INFO - 'sessionrestore', 20:56:47 INFO - 'sessionrestore_no_auto_restore', 20:56:47 INFO - 'tabpaint']}, 20:56:47 INFO - 'other-e10s': {'tests': ['a11yr', 20:56:47 INFO - 'ts_paint', 20:56:47 INFO - 'tpaint', 20:56:47 INFO - 'sessionrestore', 20:56:47 INFO - 'sessionrestore_no_auto_restore', 20:56:47 INFO - 'tabpaint']}, 20:56:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:56:47 INFO - 'ts_paint', 20:56:47 INFO - 'tpaint', 20:56:47 INFO - 'sessionrestore', 20:56:47 INFO - 'sessionrestore_no_auto_restore', 20:56:47 INFO - 'tabpaint']}, 20:56:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:56:47 INFO - 'ts_paint', 20:56:47 INFO - 'tpaint', 20:56:47 INFO - 'sessionrestore', 20:56:47 INFO - 'sessionrestore_no_auto_restore', 20:56:47 INFO - 'tabpaint']}, 20:56:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['a11yr', 20:56:47 INFO - 'ts_paint', 20:56:47 INFO - 'tpaint', 20:56:47 INFO - 'sessionrestore', 20:56:47 INFO - 'sessionrestore_no_auto_restore', 20:56:47 INFO - 'tabpaint']}, 20:56:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['a11yr', 20:56:47 INFO - 'ts_paint', 20:56:47 INFO - 'tpaint', 20:56:47 INFO - 'sessionrestore', 20:56:47 INFO - 'sessionrestore_no_auto_restore', 20:56:47 INFO - 'tabpaint']}, 20:56:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['tsvgx', 20:56:47 INFO - 'tsvgr_opacity', 20:56:47 INFO - 'tart', 20:56:47 INFO - 'tscrollx', 20:56:47 INFO - 'cart']}, 20:56:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:56:47 INFO - 'tsvgr_opacity', 20:56:47 INFO - 'tart', 20:56:47 INFO - 'tscrollx', 20:56:47 INFO - 'cart']}, 20:56:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'talos_options': ['--disable-e10s'], 20:56:47 INFO - 'tests': ['tp5o']}, 20:56:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'tests': ['tp5o']}, 20:56:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'talos_options': ['--disable-e10s', 20:56:47 INFO - '--xperf_path', 20:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:47 INFO - 'tests': ['tp5n']}, 20:56:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:47 INFO - 'talos_options': ['--xperf_path', 20:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:47 INFO - 'tests': ['tp5n']}}, 20:56:47 INFO - 'talos.zip': {'path': '', 20:56:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:56:47 INFO - Running post-action listener: _resource_record_post_action 20:56:47 INFO - [mozharness: 2016-09-14 03:56:47.266306Z] Finished populate-webroot step (success) 20:56:47 INFO - [mozharness: 2016-09-14 03:56:47.266395Z] Running create-virtualenv step. 20:56:47 INFO - Running pre-action listener: _resource_record_pre_action 20:56:47 INFO - Running main action method: create_virtualenv 20:56:47 INFO - Creating virtualenv /builds/slave/test/build/venv 20:56:47 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 20:56:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:56:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:56:47 INFO - Using real prefix '/usr' 20:56:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:56:47 INFO - Installing distribute.............................................................................................................................................................................................done. 20:56:49 INFO - Installing pip.................done. 20:56:49 INFO - Return code: 0 20:56:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:49 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:56:49 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 20:56:49 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 20:56:49 INFO - Using env: {'DISPLAY': ':0', 20:56:49 INFO - 'HOME': '/home/cltbld', 20:56:49 INFO - 'LANG': 'en_US.UTF-8', 20:56:49 INFO - 'LANGUAGE': 'en_US:en', 20:56:49 INFO - 'LOGNAME': 'cltbld', 20:56:49 INFO - 'MAIL': '/var/mail/cltbld', 20:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:49 INFO - 'MOZ_NO_REMOTE': '1', 20:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:49 INFO - 'NO_EM_RESTART': '1', 20:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:49 INFO - 'PWD': '/builds/slave/test', 20:56:49 INFO - 'SHELL': '/bin/bash', 20:56:49 INFO - 'SHLVL': '1', 20:56:49 INFO - 'TERM': 'linux', 20:56:49 INFO - 'TMOUT': '86400', 20:56:49 INFO - 'USER': 'cltbld', 20:56:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:49 INFO - '_': '/tools/buildbot/bin/python'} 20:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:50 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 20:56:50 INFO - Cleaning up... 20:56:50 INFO - Return code: 0 20:56:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:50 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:56:50 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 20:56:50 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 20:56:50 INFO - Using env: {'DISPLAY': ':0', 20:56:50 INFO - 'HOME': '/home/cltbld', 20:56:50 INFO - 'LANG': 'en_US.UTF-8', 20:56:50 INFO - 'LANGUAGE': 'en_US:en', 20:56:50 INFO - 'LOGNAME': 'cltbld', 20:56:50 INFO - 'MAIL': '/var/mail/cltbld', 20:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:50 INFO - 'MOZ_NO_REMOTE': '1', 20:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:50 INFO - 'NO_EM_RESTART': '1', 20:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:50 INFO - 'PWD': '/builds/slave/test', 20:56:50 INFO - 'SHELL': '/bin/bash', 20:56:50 INFO - 'SHLVL': '1', 20:56:50 INFO - 'TERM': 'linux', 20:56:50 INFO - 'TMOUT': '86400', 20:56:50 INFO - 'USER': 'cltbld', 20:56:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:50 INFO - '_': '/tools/buildbot/bin/python'} 20:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:50 INFO - Downloading/unpacking psutil>=3.1.1 20:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:52 INFO - Installing collected packages: psutil 20:56:52 INFO - Running setup.py install for psutil 20:56:52 INFO - building 'psutil._psutil_linux' extension 20:56:52 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 20:56:52 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 20:56:52 INFO - building 'psutil._psutil_posix' extension 20:56:52 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 20:56:52 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 20:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:52 INFO - Successfully installed psutil 20:56:52 INFO - Cleaning up... 20:56:52 INFO - Return code: 0 20:56:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:52 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:56:52 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 20:56:52 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 20:56:52 INFO - Using env: {'DISPLAY': ':0', 20:56:52 INFO - 'HOME': '/home/cltbld', 20:56:52 INFO - 'LANG': 'en_US.UTF-8', 20:56:52 INFO - 'LANGUAGE': 'en_US:en', 20:56:52 INFO - 'LOGNAME': 'cltbld', 20:56:52 INFO - 'MAIL': '/var/mail/cltbld', 20:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:52 INFO - 'MOZ_NO_REMOTE': '1', 20:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:52 INFO - 'NO_EM_RESTART': '1', 20:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:52 INFO - 'PWD': '/builds/slave/test', 20:56:52 INFO - 'SHELL': '/bin/bash', 20:56:52 INFO - 'SHLVL': '1', 20:56:52 INFO - 'TERM': 'linux', 20:56:52 INFO - 'TMOUT': '86400', 20:56:52 INFO - 'USER': 'cltbld', 20:56:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:52 INFO - '_': '/tools/buildbot/bin/python'} 20:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:56:53 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 20:56:53 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 20:56:53 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 20:56:53 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 20:56:53 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 20:56:53 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 20:56:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:56:54 INFO - Installing collected packages: mozsystemmonitor 20:56:54 INFO - Running setup.py install for mozsystemmonitor 20:56:55 INFO - Successfully installed mozsystemmonitor 20:56:55 INFO - Cleaning up... 20:56:55 INFO - Return code: 0 20:56:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:56:55 INFO - Using env: {'DISPLAY': ':0', 20:56:55 INFO - 'HOME': '/home/cltbld', 20:56:55 INFO - 'LANG': 'en_US.UTF-8', 20:56:55 INFO - 'LANGUAGE': 'en_US:en', 20:56:55 INFO - 'LOGNAME': 'cltbld', 20:56:55 INFO - 'MAIL': '/var/mail/cltbld', 20:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:55 INFO - 'MOZ_NO_REMOTE': '1', 20:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:55 INFO - 'NO_EM_RESTART': '1', 20:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:55 INFO - 'PWD': '/builds/slave/test', 20:56:55 INFO - 'SHELL': '/bin/bash', 20:56:55 INFO - 'SHLVL': '1', 20:56:55 INFO - 'TERM': 'linux', 20:56:55 INFO - 'TMOUT': '86400', 20:56:55 INFO - 'USER': 'cltbld', 20:56:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:55 INFO - '_': '/tools/buildbot/bin/python'} 20:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:55 INFO - Downloading/unpacking jsonschema==2.5.1 20:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:56:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:56:57 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 20:56:57 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 20:56:57 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 20:56:57 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 20:56:57 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 20:56:57 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 20:56:57 INFO - Downloading functools32-3.2.3-2.tar.gz 20:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:56:57 INFO - warning: no files found matching '*.txt' 20:56:57 INFO - no previously-included directories found matching 'build' 20:56:57 INFO - no previously-included directories found matching 'dist' 20:56:57 INFO - no previously-included directories found matching '.git*' 20:56:57 INFO - Installing collected packages: jsonschema, functools32 20:56:57 INFO - Running setup.py install for functools32 20:56:57 INFO - warning: no files found matching '*.txt' 20:56:57 INFO - no previously-included directories found matching 'build' 20:56:57 INFO - no previously-included directories found matching 'dist' 20:56:57 INFO - no previously-included directories found matching '.git*' 20:56:57 INFO - Successfully installed jsonschema functools32 20:56:57 INFO - Cleaning up... 20:56:57 INFO - Return code: 0 20:56:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:56:57 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')]} 20:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 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')]} 20:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:56:57 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 20:56:57 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 20:56:57 INFO - Using env: {'DISPLAY': ':0', 20:56:57 INFO - 'HOME': '/home/cltbld', 20:56:57 INFO - 'LANG': 'en_US.UTF-8', 20:56:57 INFO - 'LANGUAGE': 'en_US:en', 20:56:57 INFO - 'LOGNAME': 'cltbld', 20:56:57 INFO - 'MAIL': '/var/mail/cltbld', 20:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:57 INFO - 'MOZ_NO_REMOTE': '1', 20:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:57 INFO - 'NO_EM_RESTART': '1', 20:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:57 INFO - 'PWD': '/builds/slave/test', 20:56:57 INFO - 'SHELL': '/bin/bash', 20:56:57 INFO - 'SHLVL': '1', 20:56:57 INFO - 'TERM': 'linux', 20:56:57 INFO - 'TMOUT': '86400', 20:56:57 INFO - 'USER': 'cltbld', 20:56:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:57 INFO - '_': '/tools/buildbot/bin/python'} 20:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:56:57 INFO - Cleaning up... 20:56:57 INFO - Return code: 0 20:56:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56:57 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')]} 20:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 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')]} 20:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:56:57 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 20:56:57 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 20:56:57 INFO - Using env: {'DISPLAY': ':0', 20:56:57 INFO - 'HOME': '/home/cltbld', 20:56:57 INFO - 'LANG': 'en_US.UTF-8', 20:56:57 INFO - 'LANGUAGE': 'en_US:en', 20:56:57 INFO - 'LOGNAME': 'cltbld', 20:56:57 INFO - 'MAIL': '/var/mail/cltbld', 20:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:57 INFO - 'MOZ_NO_REMOTE': '1', 20:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:57 INFO - 'NO_EM_RESTART': '1', 20:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:57 INFO - 'PWD': '/builds/slave/test', 20:56:57 INFO - 'SHELL': '/bin/bash', 20:56:57 INFO - 'SHLVL': '1', 20:56:57 INFO - 'TERM': 'linux', 20:56:57 INFO - 'TMOUT': '86400', 20:56:57 INFO - 'USER': 'cltbld', 20:56:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:57 INFO - '_': '/tools/buildbot/bin/python'} 20:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:59 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:57:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:57:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:57:00 INFO - Downloading docopt-0.6.1.tar.gz 20:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:57:00 INFO - Installing collected packages: blobuploader, requests, docopt 20:57:00 INFO - Running setup.py install for blobuploader 20:57:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:57:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:57:00 INFO - Running setup.py install for requests 20:57:01 INFO - Running setup.py install for docopt 20:57:01 INFO - Successfully installed blobuploader requests docopt 20:57:01 INFO - Cleaning up... 20:57:01 INFO - Return code: 0 20:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:01 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')]} 20:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:01 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')]} 20:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:01 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:57:01 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 20:57:01 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 20:57:01 INFO - Using env: {'DISPLAY': ':0', 20:57:01 INFO - 'HOME': '/home/cltbld', 20:57:01 INFO - 'LANG': 'en_US.UTF-8', 20:57:01 INFO - 'LANGUAGE': 'en_US:en', 20:57:01 INFO - 'LOGNAME': 'cltbld', 20:57:01 INFO - 'MAIL': '/var/mail/cltbld', 20:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:01 INFO - 'MOZ_NO_REMOTE': '1', 20:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:01 INFO - 'NO_EM_RESTART': '1', 20:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:01 INFO - 'PWD': '/builds/slave/test', 20:57:01 INFO - 'SHELL': '/bin/bash', 20:57:01 INFO - 'SHLVL': '1', 20:57:01 INFO - 'TERM': 'linux', 20:57:01 INFO - 'TMOUT': '86400', 20:57:01 INFO - 'USER': 'cltbld', 20:57:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:01 INFO - '_': '/tools/buildbot/bin/python'} 20:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:01 INFO - Running setup.py (path:/tmp/pip-eOa0vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:01 INFO - Running setup.py (path:/tmp/pip-s_KSGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:01 INFO - Running setup.py (path:/tmp/pip-DJypo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:01 INFO - Running setup.py (path:/tmp/pip-EerYF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:01 INFO - Running setup.py (path:/tmp/pip-hujEaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:01 INFO - Running setup.py (path:/tmp/pip-m1_Os3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:01 INFO - Running setup.py (path:/tmp/pip-l6WiXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:02 INFO - Running setup.py (path:/tmp/pip-n4vjY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:02 INFO - Running setup.py (path:/tmp/pip-manVy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:02 INFO - Running setup.py (path:/tmp/pip-dRxwL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:02 INFO - Running setup.py (path:/tmp/pip-MyNmE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:02 INFO - Running setup.py (path:/tmp/pip-Yqcx6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:02 INFO - Running setup.py (path:/tmp/pip-vwV9YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:02 INFO - Running setup.py (path:/tmp/pip-rHp9ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:02 INFO - Running setup.py (path:/tmp/pip-lfZcUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:02 INFO - Running setup.py (path:/tmp/pip-PuraY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:02 INFO - Running setup.py (path:/tmp/pip-DfEbTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:57:02 INFO - Running setup.py install for manifestparser 20:57:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:57:02 INFO - Running setup.py install for mozcrash 20:57:02 INFO - Running setup.py install for mozdebug 20:57:03 INFO - Running setup.py install for mozdevice 20:57:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozfile 20:57:03 INFO - Running setup.py install for mozhttpd 20:57:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozinfo 20:57:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozInstall 20:57:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozleak 20:57:03 INFO - Running setup.py install for mozlog 20:57:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for moznetwork 20:57:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:57:03 INFO - Running setup.py install for mozprocess 20:57:04 INFO - Running setup.py install for mozprofile 20:57:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:57:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:57:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:57:04 INFO - Running setup.py install for mozrunner 20:57:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:57:04 INFO - Running setup.py install for mozscreenshot 20:57:04 INFO - Running setup.py install for moztest 20:57:04 INFO - Running setup.py install for mozversion 20:57:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:57:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:57:04 INFO - Cleaning up... 20:57:04 INFO - Return code: 0 20:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:04 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:57:04 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 20:57:04 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 20:57:04 INFO - Using env: {'DISPLAY': ':0', 20:57:04 INFO - 'HOME': '/home/cltbld', 20:57:04 INFO - 'LANG': 'en_US.UTF-8', 20:57:04 INFO - 'LANGUAGE': 'en_US:en', 20:57:04 INFO - 'LOGNAME': 'cltbld', 20:57:04 INFO - 'MAIL': '/var/mail/cltbld', 20:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:04 INFO - 'MOZ_NO_REMOTE': '1', 20:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:04 INFO - 'NO_EM_RESTART': '1', 20:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:04 INFO - 'PWD': '/builds/slave/test', 20:57:04 INFO - 'SHELL': '/bin/bash', 20:57:04 INFO - 'SHLVL': '1', 20:57:04 INFO - 'TERM': 'linux', 20:57:04 INFO - 'TMOUT': '86400', 20:57:04 INFO - 'USER': 'cltbld', 20:57:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:04 INFO - '_': '/tools/buildbot/bin/python'} 20:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:57:04 INFO - Running setup.py (path:/tmp/pip-3Rb_yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:57:04 INFO - Running setup.py (path:/tmp/pip-5oAXfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:57:04 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)) 20:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:57:04 INFO - Running setup.py (path:/tmp/pip-YpOXs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:57:05 INFO - Running setup.py (path:/tmp/pip-vV9lyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:57:05 INFO - Running setup.py (path:/tmp/pip-hS6bqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:57:05 INFO - Running setup.py (path:/tmp/pip-HP2vN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:57:05 INFO - Running setup.py (path:/tmp/pip-dgvmbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:05 INFO - Running setup.py (path:/tmp/pip-sctg_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:05 INFO - Running setup.py (path:/tmp/pip-4eY7hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:05 INFO - Running setup.py (path:/tmp/pip-y749JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:05 INFO - Running setup.py (path:/tmp/pip-Td7MVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:05 INFO - Running setup.py (path:/tmp/pip-5pIDqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:05 INFO - Running setup.py (path:/tmp/pip-zzbZPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:05 INFO - Running setup.py (path:/tmp/pip-4pXQ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:05 INFO - Running setup.py (path:/tmp/pip-wq9Exk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:05 INFO - Running setup.py (path:/tmp/pip-swAokA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:05 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)) 20:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:05 INFO - Running setup.py (path:/tmp/pip-8fe2Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:06 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)) 20:57:06 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)) 20:57:06 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)) 20:57:06 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)) 20:57:06 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)) 20:57:06 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)) 20:57:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57:06 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 20:57:06 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 20:57:06 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 20:57:06 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 20:57:06 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 20:57:06 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 20:57:08 INFO - Downloading blessings-1.6.tar.gz 20:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:57:08 INFO - Installing collected packages: blessings 20:57:08 INFO - Running setup.py install for blessings 20:57:09 INFO - Successfully installed blessings 20:57:09 INFO - Cleaning up... 20:57:09 INFO - Return code: 0 20:57:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:09 INFO - Reading from file tmpfile_stdout 20:57:09 INFO - Current package versions: 20:57:09 INFO - argparse == 1.2.1 20:57:09 INFO - blessings == 1.6 20:57:09 INFO - blobuploader == 1.2.4 20:57:09 INFO - docopt == 0.6.1 20:57:09 INFO - functools32 == 3.2.3-2 20:57:09 INFO - jsonschema == 2.5.1 20:57:09 INFO - manifestparser == 1.1 20:57:09 INFO - mozInstall == 1.12 20:57:09 INFO - mozcrash == 0.17 20:57:09 INFO - mozdebug == 0.1 20:57:09 INFO - mozdevice == 0.48 20:57:09 INFO - mozfile == 1.2 20:57:09 INFO - mozhttpd == 0.7 20:57:09 INFO - mozinfo == 0.9 20:57:09 INFO - mozleak == 0.1 20:57:09 INFO - mozlog == 3.3 20:57:09 INFO - moznetwork == 0.27 20:57:09 INFO - mozprocess == 0.23 20:57:09 INFO - mozprofile == 0.28 20:57:09 INFO - mozrunner == 6.12 20:57:09 INFO - mozscreenshot == 0.1 20:57:09 INFO - mozsystemmonitor == 0.3 20:57:09 INFO - moztest == 0.7 20:57:09 INFO - mozversion == 1.4 20:57:09 INFO - psutil == 3.1.1 20:57:09 INFO - requests == 1.2.3 20:57:09 INFO - wsgiref == 0.1.2 20:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57:09 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')]} 20:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:09 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')]} 20:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:09 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:57:09 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 20:57:09 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 20:57:09 INFO - Using env: {'DISPLAY': ':0', 20:57:09 INFO - 'HOME': '/home/cltbld', 20:57:09 INFO - 'LANG': 'en_US.UTF-8', 20:57:09 INFO - 'LANGUAGE': 'en_US:en', 20:57:09 INFO - 'LOGNAME': 'cltbld', 20:57:09 INFO - 'MAIL': '/var/mail/cltbld', 20:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:09 INFO - 'MOZ_NO_REMOTE': '1', 20:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:09 INFO - 'NO_EM_RESTART': '1', 20:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:09 INFO - 'PWD': '/builds/slave/test', 20:57:09 INFO - 'SHELL': '/bin/bash', 20:57:09 INFO - 'SHLVL': '1', 20:57:09 INFO - 'TERM': 'linux', 20:57:09 INFO - 'TMOUT': '86400', 20:57:09 INFO - 'USER': 'cltbld', 20:57:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:09 INFO - '_': '/tools/buildbot/bin/python'} 20:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 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)) 20:57:09 INFO - Cleaning up... 20:57:09 INFO - Return code: 0 20:57:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:57:09 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')]} 20:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:09 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')]} 20:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:09 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 0x2780030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, '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': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', '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 20:57:09 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 20:57:09 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 20:57:09 INFO - Using env: {'DISPLAY': ':0', 20:57:09 INFO - 'HOME': '/home/cltbld', 20:57:09 INFO - 'LANG': 'en_US.UTF-8', 20:57:09 INFO - 'LANGUAGE': 'en_US:en', 20:57:09 INFO - 'LOGNAME': 'cltbld', 20:57:09 INFO - 'MAIL': '/var/mail/cltbld', 20:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:09 INFO - 'MOZ_NO_REMOTE': '1', 20:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:09 INFO - 'NO_EM_RESTART': '1', 20:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:09 INFO - 'PWD': '/builds/slave/test', 20:57:09 INFO - 'SHELL': '/bin/bash', 20:57:09 INFO - 'SHLVL': '1', 20:57:09 INFO - 'TERM': 'linux', 20:57:09 INFO - 'TMOUT': '86400', 20:57:09 INFO - 'USER': 'cltbld', 20:57:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:09 INFO - '_': '/tools/buildbot/bin/python'} 20:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:57:09 INFO - Cleaning up... 20:57:09 INFO - Return code: 0 20:57:09 INFO - Running post-action listener: _resource_record_post_action 20:57:09 INFO - Running post-action listener: _start_resource_monitoring 20:57:09 INFO - Starting resource monitoring. 20:57:09 INFO - [mozharness: 2016-09-14 03:57:09.833897Z] Finished create-virtualenv step (success) 20:57:09 INFO - [mozharness: 2016-09-14 03:57:09.834373Z] Running install step. 20:57:09 INFO - Running pre-action listener: _resource_record_pre_action 20:57:09 INFO - Running main action method: install 20:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:10 INFO - Reading from file tmpfile_stdout 20:57:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:57:10 INFO - Reading from file tmpfile_stdout 20:57:10 INFO - Output received: 20:57:10 INFO - Usage: mozinstall [options] installer 20:57:10 INFO - Options: 20:57:10 INFO - -h, --help show this help message and exit 20:57:10 INFO - -d DEST, --destination=DEST 20:57:10 INFO - Directory to install application into. [default: 20:57:10 INFO - "/builds/slave/test"] 20:57:10 INFO - --app=APP Application being installed. [default: firefox] 20:57:10 INFO - mkdir: /builds/slave/test/build/application 20:57:10 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'] 20:57:10 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 20:57:27 INFO - Reading from file tmpfile_stdout 20:57:27 INFO - Output received: 20:57:27 INFO - /builds/slave/test/build/application/firefox/firefox 20:57:27 INFO - Running post-action listener: _resource_record_post_action 20:57:27 INFO - [mozharness: 2016-09-14 03:57:27.088199Z] Finished install step (success) 20:57:27 INFO - [mozharness: 2016-09-14 03:57:27.088478Z] Running run-tests step. 20:57:27 INFO - Running pre-action listener: _resource_record_pre_action 20:57:27 INFO - Running main action method: run_tests 20:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:57:27 INFO - Python 2.7.3 20:57:27 INFO - Return code: 0 20:57:27 INFO - grabbing minidump binary from tooltool 20:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:27 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 0x2a3e570>, '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 0x2a3f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:57:27 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 20:57:27 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 20:57:27 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 20:57:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:57:27 INFO - Return code: 0 20:57:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:57:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:57:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:57:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:57:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:57:27 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/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 20:57:27 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/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 20:57:27 INFO - Using env: {'DISPLAY': ':0', 20:57:27 INFO - 'HOME': '/home/cltbld', 20:57:27 INFO - 'LANG': 'en_US.UTF-8', 20:57:27 INFO - 'LANGUAGE': 'en_US:en', 20:57:27 INFO - 'LOGNAME': 'cltbld', 20:57:27 INFO - 'MAIL': '/var/mail/cltbld', 20:57:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:57:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:27 INFO - 'MOZ_NO_REMOTE': '1', 20:57:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:27 INFO - 'NO_EM_RESTART': '1', 20:57:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:27 INFO - 'PWD': '/builds/slave/test', 20:57:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:57:27 INFO - 'SHELL': '/bin/bash', 20:57:27 INFO - 'SHLVL': '1', 20:57:27 INFO - 'TERM': 'linux', 20:57:27 INFO - 'TMOUT': '86400', 20:57:27 INFO - 'USER': 'cltbld', 20:57:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999', 20:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:27 INFO - '_': '/tools/buildbot/bin/python'} 20:57:27 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/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 20:57:27 INFO - mozversion application_buildid: 20160913190821 20:57:27 INFO - mozversion application_changeset: 3c621f8c782957aeda376304afe884139b7ee49a 20:57:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:57:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:57:27 INFO - mozversion application_name: Firefox 20:57:27 INFO - mozversion application_remotingname: firefox-dev 20:57:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:57:27 INFO - mozversion application_vendor: Mozilla 20:57:27 INFO - mozversion application_version: 50.0a2 20:57:27 INFO - mozversion platform_buildid: 20160913190821 20:57:27 INFO - mozversion platform_changeset: 3c621f8c782957aeda376304afe884139b7ee49a 20:57:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:57:27 INFO - mozversion platform_version: 50.0a2 20:57:27 INFO - using testdate: 1473825447 20:57:27 INFO - actual date: 1473825447 20:57:27 INFO - starting webserver on 'localhost:47606' 20:57:27 INFO - SUITE-START | Running 2 tests 20:57:27 INFO - TEST-START | dromaeo_css 20:57:27 INFO - operating with platform_type : linux_ 20:57:27 INFO - Initialising browser for dromaeo_css test... 20:57:27 INFO - TEST-INFO | started process 9412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnO_MaN/profile http://localhost:47606/getInfo.html) 20:57:32 INFO - PROCESS | 9412 | __metrics Screen width/height:1600/1200 20:57:32 INFO - PROCESS | 9412 | colorDepth:24 20:57:32 INFO - PROCESS | 9412 | Browser inner width/height: 1024/697 20:57:32 INFO - PROCESS | 9412 | __metrics 20:57:32 ERROR - PROCESS | 9412 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:57:33 INFO - TEST-INFO | 9412: exit 0 20:57:33 INFO - Browser initialized. 20:57:33 INFO - Running cycle 1/1 for dromaeo_css test... 20:57:33 INFO - TEST-INFO | started process 9537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnO_MaN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:57:45 INFO - PROCESS | 9537 | RSS: Main: 153477120 20:57:45 INFO - PROCESS | 9537 | 20:58:35 INFO - PROCESS | 9537 | 1473825515082 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] 21:00:43 INFO - PROCESS | 9537 | Cycle 1(1): loaded http://localhost:47606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47606/tests/dromaeo/cssquery-ext.html) 21:00:44 INFO - PROCESS | 9537 | RSS: Main: 159821824 21:00:44 INFO - PROCESS | 9537 | 21:03:46 INFO - PROCESS | 9537 | Cycle 1(1): loaded http://localhost:47606/tests/dromaeo/cssquery-ext.html (next: http://localhost:47606/tests/dromaeo/cssquery-jquery.html) 21:03:46 INFO - PROCESS | 9537 | RSS: Main: 155537408 21:03:46 INFO - PROCESS | 9537 | 21:06:48 INFO - PROCESS | 9537 | Cycle 1(1): loaded http://localhost:47606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47606/tests/dromaeo/cssquery-mootools.html) 21:06:49 INFO - PROCESS | 9537 | RSS: Main: 156467200 21:06:49 INFO - PROCESS | 9537 | 21:09:51 INFO - PROCESS | 9537 | Cycle 1(1): loaded http://localhost:47606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47606/tests/dromaeo/cssquery-prototype.html) 21:09:51 INFO - PROCESS | 9537 | RSS: Main: 154677248 21:09:51 INFO - PROCESS | 9537 | 21:12:54 INFO - PROCESS | 9537 | Cycle 1(1): loaded http://localhost:47606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47606/tests/dromaeo/cssquery-yui.html) 21:12:54 INFO - PROCESS | 9537 | RSS: Main: 157155328 21:12:54 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | Cycle 1(1): loaded http://localhost:47606/tests/dromaeo/cssquery-yui.html (next: http://localhost:47606/tests/dromaeo/cssquery-dojo.html) 21:15:57 INFO - PROCESS | 9537 | RSS: Main: 157478912 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | __start_tp_report 21:15:57 INFO - PROCESS | 9537 | _x_x_mozilla_page_load 21:15:57 INFO - PROCESS | 9537 | _x_x_mozilla_page_load_details 21:15:57 INFO - PROCESS | 9537 | |i|pagename|runs| 21:15:57 INFO - PROCESS | 9537 | |0;dojo.html;3266.6896644818744;3275.39405210036;3288.4738441849295;3290.459758095438;3311.1556553078976;5649.180868774025;5699.173619825123;5699.344575373833;5700.80283140541;5705.4294570542925;5645.576581756364;5676.403977582346;5690.231818704484;5705.6006079574345;5724.4561766632205;5160.458151894053;5183.688978661293;5213.869653258661;5260.868478288055;5287.312649355597;4984.601231901439;4997.4003119625695;5008.899822003557;5017.071841709278;5085.415177254626;5162.199859021839;5183.403908550527;5195.870103247411;5197.818076367328;5238.52853243208;5201.115810312256;5205.479452054802;5220.530152286275;5228.92156617651;5258.50044245796;4894.608431325485;4954.925676114861;4970.950290497121;5116.872078198075;5137.768800403991;5462.0987537056335;5503.422140675251;5503.6147469677135;5512.531434828044;5551.805686800943;5868.941310586925;5869.1196320551835;5905.852353691149;5919.496842768327;5922.200502932092;5781.046127388976;5905.940940590582;5941.524678025748;5943.881122377528;5953.821385358447;5596.636218645775;5612.382637909826;5617.719114044281;5633.915491267634;5643.1535269709875;6066.939330606726;6085.756569737161;6101.694915254219;6116.908246376308;6118.816435506942;5712.714364281769;5840.977828879929;5852.502537284378;5889.352171261158;5894.823155305347;6052.969735151384;6055.303640081359;6080.209572755513;6095.268567771807;6098.420650038239;5980.85047873798;6010.9699451502465;6019.849503762441;6050.909236361458;6051.757929682852;5723.427657234327;5916.940830591725;5932.584719069624;5958.255218097738;6048.788292409745;4598.632109431237;4613.792379342937;4628.421447319085;4646.883827904329;4655.976720116378;4122.628963393309;4132.049628585382;4140.648044916215;4142.544320124784;4169.124483858363;5588.329400471969;5612.803551875746;5650.660960342392;5836.533077353802;5842.5618078644275;6002.789902353396;6007.189029481052;6012.669303188367;6024.277086749618;6047.606905551125;5656.236408084938;5702.173184888251;5743.339515955635;5744.052231381859;5748.39641837601;5026.045051440215;5152.407473140637;5161.174212126042;5177.896442071137;5199.4540573239265;6209;6232.875342493125;6252.030935205051;6258.405451482102;6260.217472815898;6033.728482218223;6039.365866583946;6049.062395328643;6052.636841789506;6061.909071364022;5988.041913293852;6039.607425517327;6068.757249710139;6141.8464538385115;6144.354842741448;5776.826695199151;5812.564057695605;5813.854653633693;5814.5639077068545;5824.912626310524;5908.468237858613;5913.940860591339;5924.526037917042;5931.110333449845;5936.970315148396;5595.104783234663;5794.855128621818;5844.590878638454;5875.471207591338;5931.673757943182;5860.648361098348;5867.413258674099;5867.471927526543;5870.5010074142465;5884.146798714077;5812.476877081083;5859.121131830259;5867.853303667443;5870.5010074142465;5883.852903677443;5698.857528561653;5717.971410142923;5773.826785196451;5869.765209391577;5961.135635332766;5765.56758243125;5767.769289228384;5792.768289268382;5812.21535092757;5821.505172060253 21:15:57 INFO - PROCESS | 9537 | |1;ext.html;598.1864664056882;645.5029627187065;655.786869267488;668.8361351468891;722.1839321566629;40347.193056138894;43991;44267.55732442674;44277.114457710864;44397.556024439786;45826;46140.76929615356;46306.30540541895;46401.53598464014;46527.76736116315;8950.86573701395;9057.320700947423;9094.363394562382;9102.22631076356;9142.085791420872;9005.954970225172;9098.86351704725;9112.772180695469;9127.543622818866;9129.087091290885;9055.683051093212;9116.589753461078;9135.451872887648;9138.268938484938;9148.771280717969;9146.908530914705;9229.953850230739;9246.12161844627;9254.259659227313;9258.120478554527;9064.274858011344;9110.954445227797;9117;9124.771880703036;9135.40619859707;43025.56974430247;43151.13697726059;43276.567234327566;43326;43370.34944475835;3783.6973042156837;3870.59358767331;3976.8608098716695;4058.959410405888;4685.8594242172785;34184.31631367359;34218;34371;34923.1269218269;35813.28373432517;4177.644900183488;4179.791010449496;4195.832166713328;4216.3464662977285;4250.383694364331;257077;257477;259694;260322;261545;38454.80772596119;39713.60286397099;60659.69670151621;60802.8718994833;61274.69362653158;40425.595744042184;40673.593264067575;40760.18479630391;40829.79585102056;40860.591394086274;17269.13654317279;17425;17439.389621363192;17441.7383739244;17448.563785905455;14241.145531268157;14298.714025719428;14335.211563363906;14414.207218603078;14430.639234019234;9125.954370228239;9141.634334626673;9235.076492350845;9240.122188392092;9293.814123717488;3474.409350410436;3598.1184609770776;3620.71034317254;3663.9633603664156;3685.0603096210293;1065.5524679634573;1080.303204433152;1129.2490493821517;1134.1550544843979;1205.3306170953117;32627.83686081602;33153.66846331506;33261.50107748386;33765.83117084399;34045.489317660256;1169.7952858249773;1229.3668760588125;1249.3940438887132;1272.5291642092484;1293.9158954667917;16983.660326793393;17562.912185438992;17661.38185163513;17777.288908443777;17786.401970296498;583273;625053;626409;635452;943800;64475;65313;65491.34508654852;65620.67189664021;65909;1467.288365142905;1485.0718301061836;1497.3561368611602;1518.3546992528131;1527.0913806285243;34274.657253428144;34421;35301.646983529834;35365;35459.11352216215;54064.189037163684;54666.72666636641;54802.45197547974;54882.72558637181;54978.45021549733;548589;550521;551284;552359;553321;30742.846285768428;31312.843435782674;31345.373092537564;31739.841300794273;31780.841095794374;52132.73933630308;52450.213246800566;52598.47401526089;53070.73464632806;53153.46846531485;43574.346384804885;43931.78034109809;44899.10201796011;45623.31565026593;46333.30500042435;44676;44862.775686122666;45329.320060198464;46192.76903615595;46194.53805462037;43809.56190438055;44055.559444406426;44098.77950610226;44453.555464444944;44967.55032449764;38945.22109557736;39725.404118938815;39749.84502789526;40113.598864010986;40184.1963160741;30191.849040754656;30311.848440757654;30639.693603064577;30760.846195768878;31300.686993129777 21:15:57 INFO - PROCESS | 9537 | |2;jquery.html;418.2116710001646;426.73115936959715;432.4702239756297;433.5642679107497;448.5245639622001;19349.419517414466;20272.89863550682;20761.584768304623;20798.272060477888;20933.74397536147;19303.13135908884;20687.896560517176;20899.68650470244;21207;21235.469113272175;5931.199288096116;6144.723487443076;6147.907781383283;6149.169862068608;6153.230846144232;5935.88128237435;6042.9395706042815;6079.848003799918;6085.208922840025;6086.482648974842;5732.369439361667;5874.73563689635;5951.791687290945;6010.218671572689;6051.727672254759;5899.292084949812;5931.584789064767;5985.132155837401;6033.728482218311;6050.515958723292;5353.4646535346155;5360.544353729938;5428.891422171534;5447.073997420448;5447.509724124848;24402;24443.755562444505;24582.262532124067;24854.502909941883;25033.4993300133;2571.370014346497;2599.584066549362;2677.397585543257;2686.1672881406826;2694.097477345072;15805.130717810516;15925.522234332988;15935.123568203744;16233;16447.342106315733;2080.4382816639422;2091.6444204485274;2119.501917049492;2177.194438057913;2193.8793366364844;83481.58259208726;83540.58229708874;85023.57488212582;85653;87806.5609671954;9836.06557377048;10444.321119127233;10501.054905058581;10575.841362379571;10830.133589312836;14673.119612823264;14713;14718.484853030093;14721.116732996055;14749.115053096848;8495.192956669107;8632.697855575025;8676.8698469523;8679.826403472021;8738.082501337396;8780.692675756318;8804.383693141546;8835.20483156506;8994.145556172152;9011.23404510624;4503.617192538605;4513.819447222074;4515.616172625298;4524.6380289576755;4581.94615238497;2078.7089807426973;2083.7186979757844;2089.3000844716885;2121.7666056733747;2202.9709149918863;938.9859152112724;1025.4257615735212;1039.5010395010286;1047.7275908263907;1132.9859775500881;20667.689984650242;20977.89511052435;21326.466838329165;21351.893240533696;21448.356549303546;1026.7895081508423;1053.9367637941748;1065.158524765442;1072.2119242356862;1079.83262594298;11344.149188810707;11689.883101169049;11770.234934729215;11866.110041746904;11961.64115076549;523695;528170;549489;550662;554260;95700;95803;96141;98880;101323;1025.5231317437429;1058.0953284941418;1067.4075887882145;1078.0890147825075;1079.5735684404774;16284.918575407048;18542.721859171852;18638.53403664919;18647.44057678272;19009.42971710851;43481;43613.34579981239;43712.34431483466;44901.1019779596;45462;61072.38927610845;61121;61621.075683865674;61981.38018619936;62637.68681156565;9041.502717350346;9138.497382644018;9260.120288572574;9282.303827213122;9604.471754053595;11555;14157.221352825281;14311.499097531536;14316.785248221076;14433.278336082943;12056.156069075432;12119.515219391125;12571.68570785701;12597.11820172579;12831.946888497796;11729.413529323328;12132.393380330772;12318.815217771562;12329;12477.75044499123;12649.051321150766;12686.809697854354;12772.361381931052;13009.154404963647;13039.934800325938;9114.3559836968;9332.53337333117;9347.485888276211;9438.150566448778;9577.281703872099;9917.900820991697;12183.512659493521;12505.812412813997;12946.676333091747;12960.740785184054 21:15:57 INFO - PROCESS | 9537 | |3;mootools.html;1551.9922400388;1575.5037163293562;1735.8437740603342;1835.8714889957707;1865.2725437079532;8318.251357377834;9186.173244408003;9234.445933244002;9982;9996.550155243005;9480.715578532656;9793.706188814329;9795.363301385423;9814.950925245364;9868.3092183547;2462.975370246297;2482.503499300138;2504.724480307174;2509.2221411362443;2518.5718427867305;2468.419921318489;2539.6571462852557;2542.8982840686444;2547.197632745688;2548.1336345642476;2380.3573035280465;2383.4994651123284;2495.36368226103;2509.1970569417795;2516.169664010872;2395.940101497459;2436.3665446983823;2445.0342114864616;2457.680501534807;2468.8642124683133;2458.262521243638;2461.963070553943;2463.1255904153945;2476.430421003179;2477.5416547938507;9662.17871480925;9836.114749672564;9851.408915465096;9859.260555458297;9872.062154095349;5594.216809646653;5652.954203472371;5660.981023415784;5715.685637289947;5718.59969802114;3494.947575786365;3587.1390866191928;3595.5865075516126;3619.077135330474;3688.133288677159;1173.6537721372215;1210.7457433938882;1224.3449754381363;1230.95076196952;1238.102375777554;13847.930760346235;13858.861411385958;13885.791713124312;13917.721645567031;13918.652033699138;4945.159322915041;4960.801567937242;5009.674371165863;5021.5229553192385;5210.557102646318;11655.067594592412;11685.240459370283;11698.947094761343;11756.882431175749;11758.941205293919;5701.800436984686;5724.227229323988;5753.482186603226;5759.884802303931;5761.625494342854;4614.2617181250835;4993.325901003318;5055.747212639353;5116.411612664517;5257.947420525822;4217.957820421818;4316;4351.26028575143;4396.736195828196;4510.639148868083;1365.0717512091674;1368.1312366647053;1383.75784237758;1388.430743395203;1389.6595334142999;949.1599934058409;987.456898705709;1059.692689120162;1074.6937122920087;1082.7509672775147;6500.544961852719;6597.60414375139;6771.966140169267;6781.62701051437;6825.795226143224;481.5092552393752;492.5591595522059;493.27488591770043;494.4091810286745;520.6901893373437;4621.676482646182;4639.188142075123;4656.674032817738;4709.576138147583;4763.928541071887;11882.702932426759;12203.816942745865;12246.203996740362;12324.383780810924;12361.196522226026;11537.538498459968;12027.03783697302;12298.385080745928;12324.383780810924;12384.195027323376;9036.548172591343;9272.67545635913;9278.814423711623;9299.628014879465;9309.44143351401;6658.933410665832;6732.629705366252;6734.9326506734305;6833.58998460094;6929.44564434834;10893.891061089606;11126.276792008493;11302.095832333229;11334.14993875446;11342.659720208407;11452;11561.42192890369;11620.825687614524;11645.126615504041;11723.589674361356;8035.156308587748;8567.657293708182;8709.520976346108;8729.170728780755;8965.820683586422;9799.951000244953;9805.509724513604;9824.214062875095;9834.950825245827;9838.9016109838;8555.144485551395;8627.482351058956;8696.043435221995;8744.300455963381;8827.205551500396;8416.957915210385;8467.11095334981;8553.914460855312;8615.827683446421;8627.482351058956;7429.108506978981;7718.961405192938;7768.456208065381;7782.533048017137;7792.493487923267;5786.768529258782;5787.987102257004;5847.707614619167;5861.296644402699;5928.288605367384;5789.623674461147;5799.043157878903;5809.76760929575;5888.263967004124;5904.202932604044 21:15:57 INFO - PROCESS | 9537 | |4;prototype.html;358.19227641668044;360.56551855014703;361.68533375962915;362.2573723866075;366.88443140410766;5832.445917637829;5858.384869588695;5881.441263080006;5883.499902508292;5914.905742437652;5590.496855283024;5738.512226460745;5799.56503262256;5802.709864506779;5805.477507024367;4530.501644819067;4567.931481027771;4575.565321294472;4589.128065667529;4592.954070459303;4519.050999290153;4568.885777855564;4587.518310577391;4619.766163685417;4634.629229661619;4458.375827384152;4517.661175411841;4557.794899229526;4583.19794036044;4600.562946520092;4504.324351347292;4504.842330518432;4520.367148599199;4552.8861778455475;4575.611073058761;4041.4139949707424;4060.330045542482;4070.5725898780793;4081.4898137732785;4083.9183216335505;5580.776768929238;5672.716364181774;5674.120511320752;5680.375158732536;5693.686847223401;5226.268322434862;5234.162533994542;5242.9213561796605;5254.21186821976;5266.894662106774;6002.459778619946;6024.246969128859;6090.725917333686;6129.969350153266;6141.679538899158;4290.549492303326;4430.335449682541;4456.866294011184;4487.685861989662;4491.461024677027;5931.6144450611;6117.877642447126;6267.4672652824565;6279.215098112736;6299.779507717208;4530.161920044737;4535.818567257273;4550.726956382628;4564.566366195206;4573.748443835621;4558.156741002925;4600.228911868888;4607;4621.930671039937;4638.744869032235;4989.301497790312;5177.559907407913;5182.870428239249;5237.711925844039;5241.746049198881;6075.574709770273;6109.633421994606;6115.877682446326;6168.8766224675255;6186.81439556814;1554.518099389193;1557.9950931649023;1598.4884836852327;1601.6316247263194;1603.7193491139003;968.801395713877;997.8154041502345;1001.2590682894605;1015.1269907879218;1018.8792328438658;5182.352205974254;5200.97399513;5262.368515778055;5271.499207575274;5285.652158699584;5480.7533660985355;5490.972545137249;5500.477454641803;5531.059719847635;5542.501174894279;4922.9753851231235;5121.948780512147;5162.8967420652125;5233.450487698737;5255.6321057526375;2868.7234180789346;2922.4072880279873;2923.444545536384;2930.6190195274903;2936.900116416772;5593.608447408724;5710.543156547466;5724;5747.706765977621;5753.252077229933;5981.970090149608;6395.52033597482;6405;6447.2263328400895;6453.257875344396;6508.754479704495;6509.251436084911;6521.47828173745;6527.738890444329;6536.705848236841;6117.296510901303;6251.281102673069;6272.121902933684;6331.841703957438;6340.904886426615;6239.812805615838;6244.937550624617;6246.0955655620355;6272.717727702173;6278.560500765086;6180.845478863064;6294.15028971083;6428.582142160744;6455.354464553695;6477.125588045554;4432.423784907941;4443.133588950253;4451.554844515523;4456.821727130879;4469.396631454712;6167.722452489559;6236.844078898064;6314.905276420765;6346.9682651586445;6374;6129.540284478593;6130.356312587292;6132.657701552754;6158.630482171084;6179;5892.292924849045;6093.268807742922;6141.877162456815;6143.447089761943;6189.473894718999;6051.4553690168095;6099.695015249308;6102.938970610237;6116.633002019893;6116.816495505142;6155.415235552616;6156.199694039746;6160.784372546939;6165.749501432035;6232.844178895564;5768.480836724715;5973.432523910222;5994.460498555151;6002.789902353396;6016.699165041818 21:15:57 INFO - PROCESS | 9537 | |5;yui.html;778.5601135358522;788.5254573946719;801.3909428834086;824.3240542754943;871.298604623278;16419.261133249;16964.49106526803;17186.828131718677;17228.39700610476;17325.56686082847;16016.519504414886;16196.99999999997;16220.675586488263;16221.432249871257;16222.7566586501;712.6151877985882;823.0987069159261;850.8085680721819;864.1660797330575;871.3421366868038;853.185208126241;854.2525290370926;859.7119964811795;859.896812382515;862.6118246788939;918.6922381002372;918.8759517465157;921.0835218957147;921.5023887100957;921.8340698674236;899.7840518275599;907.795745957161;909.4815954905706;913.3606475467167;913.8720579118929;674.43684523423;674.4705406256114;674.8245456181379;678.1421501800227;681.2914568848391;16164.110973896431;16189.676206475922;16207.432739854166;16215.189240537926;16329.265183066791;13807.861921380758;13866.861331386759;13886.375113119933;13906;14019.088759230617;14159.362828672734;14185.848930049593;14219.289035548285;14451.349689264009;14584.124952502883;4641.257398816173;4650.7442090685;4682.953170468286;4704.1062198182235;4712.835050773207;87323.12676873214;88590.02212433492;88594.5570272151;88886.11113888843;88913.11086889177;10639.095676867399;10949.288296260876;11022.338659680445;11074.39090850011;11074.723131921604;21083.578328433654;21169.894150529148;21178;21184.682229766568;21222.151113955577;8875.866861996947;9062.682806101755;9095.181433671001;9140.360174787702;9191.080891910755;5131.640785145004;5160.0969830279555;5206.5314121729225;5300.893982120336;5372.1941708744;3778.905527361783;3902.785346805896;3920.7059470539825;3928.626780455852;3942.56631770505;665.6339013542532;678.3420082519948;685.4482141875837;693.4764252988961;698.3923986131996;655.7114869457423;659.9901001484982;685.2599192871786;691.4399336537421;713.9607321597258;8897.466152030898;9023.954880225558;9545.474998875128;9732.610695572239;10138.746531336628;608.592243197059;652.7291174162764;673.9696713647897;677.4005005570008;709.8899670551073;4626.259798432235;4826.356205102799;4848.781804818792;4867.805287788519;4944.505549445099;70940.64529677422;75475.62262188653;91878.08121918695;134915.32542337422;141628;64824.67587662126;74273.25726742664;115101;115610.42194788973;116842.41578792052;63019;97059.51470242745;102873.48563257286;106180;106850;9616.615335386507;9784.85322720174;9846.113849753556;9870.654527091518;9949.204063674744;59192.70403647954;59365.70317148387;59953;61195.694021529605;61767;84831.57584212287;89056.554717226;89132;89624;93025.53487232521;12266.202696824677;12493.25040497573;12573.182743121668;12664.936675316932;12714.872851271739;13663.385147668578;13687.31563421805;13995.300234988414;14055.859441405455;14090.506832261231;11703.76592468129;11758.412079396167;11914.940425297818;12157.27056376585;12371.75256494883;14305.856941430453;14499.130052196902;14518.201498917238;14656.193909334663;16396.67206655884;13753.312334383041;14198.29008549589;14492.347844347241;14651.633709157357;15127.470538531099;10864.239503234698;11461.25501842411;11655.825162622737;11910.404479776149;12261.509539618315;10969.23215374916;11621.24461909973;11755.823662645238;11808.87677110799;11823.113266504875 21:15:57 INFO - PROCESS | 9537 | __end_tp_report 21:15:57 INFO - PROCESS | 9537 | __start_cc_report 21:15:57 INFO - PROCESS | 9537 | _x_x_mozilla_cycle_collect,336 21:15:57 INFO - PROCESS | 9537 | __end_cc_report 21:15:57 INFO - PROCESS | 9537 | __startTimestamp1473826557316__endTimestamp 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | ------- Summary: start ------- 21:15:57 INFO - PROCESS | 9537 | Number of tests: 6 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | [#0] dojo.html Cycles:165 Average:5569.97 Median:5781.05 stddev:611.97 (10.6%) stddev-sans-first:586.57 21:15:57 INFO - PROCESS | 9537 | Values: 3266.7 3275.4 3288.5 3290.5 3311.2 5649.2 5699.2 5699.3 5700.8 5705.4 5645.6 5676.4 5690.2 5705.6 5724.5 5160.5 5183.7 5213.9 5260.9 5287.3 4984.6 4997.4 5008.9 5017.1 5085.4 5162.2 5183.4 5195.9 5197.8 5238.5 5201.1 5205.5 5220.5 5228.9 5258.5 4894.6 4954.9 4971.0 5116.9 5137.8 5462.1 5503.4 5503.6 5512.5 5551.8 5868.9 5869.1 5905.9 5919.5 5922.2 5781.0 5905.9 5941.5 5943.9 5953.8 5596.6 5612.4 5617.7 5633.9 5643.2 6066.9 6085.8 6101.7 6116.9 6118.8 5712.7 5841.0 5852.5 5889.4 5894.8 6053.0 6055.3 6080.2 6095.3 6098.4 5980.9 6011.0 6019.8 6050.9 6051.8 5723.4 5916.9 5932.6 5958.3 6048.8 4598.6 4613.8 4628.4 4646.9 4656.0 4122.6 4132.0 4140.6 4142.5 4169.1 5588.3 5612.8 5650.7 5836.5 5842.6 6002.8 6007.2 6012.7 6024.3 6047.6 5656.2 5702.2 5743.3 5744.1 5748.4 5026.0 5152.4 5161.2 5177.9 5199.5 6209.0 6232.9 6252.0 6258.4 6260.2 6033.7 6039.4 6049.1 6052.6 6061.9 5988.0 6039.6 6068.8 6141.8 6144.4 5776.8 5812.6 5813.9 5814.6 5824.9 5908.5 5913.9 5924.5 5931.1 5937.0 5595.1 5794.9 5844.6 5875.5 5931.7 5860.6 5867.4 5867.5 5870.5 5884.1 5812.5 5859.1 5867.9 5870.5 5883.9 5698.9 5718.0 5773.8 5869.8 5961.1 5765.6 5767.8 5792.8 5812.2 5821.5 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | [#1] ext.html Cycles:180 Average:65325.64 Median:43348.17 stddev:143370.13 (330.7%) stddev-sans-first:143689.95 21:15:57 INFO - PROCESS | 9537 | Values: 598.2 645.5 655.8 668.8 722.2 40347.2 43991.0 44267.6 44277.1 44397.6 45826.0 46140.8 46306.3 46401.5 46527.8 8950.9 9057.3 9094.4 9102.2 9142.1 9006.0 9098.9 9112.8 9127.5 9129.1 9055.7 9116.6 9135.5 9138.3 9148.8 9146.9 9230.0 9246.1 9254.3 9258.1 9064.3 9111.0 9117.0 9124.8 9135.4 43025.6 43151.1 43276.6 43326.0 43370.3 3783.7 3870.6 3976.9 4059.0 4685.9 34184.3 34218.0 34371.0 34923.1 35813.3 4177.6 4179.8 4195.8 4216.3 4250.4 257077.0 257477.0 259694.0 260322.0 261545.0 38454.8 39713.6 60659.7 60802.9 61274.7 40425.6 40673.6 40760.2 40829.8 40860.6 17269.1 17425.0 17439.4 17441.7 17448.6 14241.1 14298.7 14335.2 14414.2 14430.6 9126.0 9141.6 9235.1 9240.1 9293.8 3474.4 3598.1 3620.7 3664.0 3685.1 1065.6 1080.3 1129.2 1134.2 1205.3 32627.8 33153.7 33261.5 33765.8 34045.5 1169.8 1229.4 1249.4 1272.5 1293.9 16983.7 17562.9 17661.4 17777.3 17786.4 583273.0 625053.0 626409.0 635452.0 943800.0 64475.0 65313.0 65491.3 65620.7 65909.0 1467.3 1485.1 1497.4 1518.4 1527.1 34274.7 34421.0 35301.6 35365.0 35459.1 54064.2 54666.7 54802.5 54882.7 54978.5 548589.0 550521.0 551284.0 552359.0 553321.0 30742.8 31312.8 31345.4 31739.8 31780.8 52132.7 52450.2 52598.5 53070.7 53153.5 43574.3 43931.8 44899.1 45623.3 46333.3 44676.0 44862.8 45329.3 46192.8 46194.5 43809.6 44055.6 44098.8 44453.6 44967.6 38945.2 39725.4 39749.8 40113.6 40184.2 30191.8 30311.8 30639.7 30760.8 31300.7 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | [#2] jquery.html Cycles:180 Average:31441.11 Median:24718.38 stddev:89124.55 (360.6%) stddev-sans-first:89344.13 21:15:57 INFO - PROCESS | 9537 | Values: 418.2 426.7 432.5 433.6 448.5 19349.4 20272.9 20761.6 20798.3 20933.7 19303.1 20687.9 20899.7 21207.0 21235.5 5931.2 6144.7 6147.9 6149.2 6153.2 5935.9 6042.9 6079.8 6085.2 6086.5 5732.4 5874.7 5951.8 6010.2 6051.7 5899.3 5931.6 5985.1 6033.7 6050.5 5353.5 5360.5 5428.9 5447.1 5447.5 24402.0 24443.8 24582.3 24854.5 25033.5 2571.4 2599.6 2677.4 2686.2 2694.1 15805.1 15925.5 15935.1 16233.0 16447.3 2080.4 2091.6 2119.5 2177.2 2193.9 83481.6 83540.6 85023.6 85653.0 87806.6 9836.1 10444.3 10501.1 10575.8 10830.1 14673.1 14713.0 14718.5 14721.1 14749.1 8495.2 8632.7 8676.9 8679.8 8738.1 8780.7 8804.4 8835.2 8994.1 9011.2 4503.6 4513.8 4515.6 4524.6 4581.9 2078.7 2083.7 2089.3 2121.8 2203.0 939.0 1025.4 1039.5 1047.7 1133.0 20667.7 20977.9 21326.5 21351.9 21448.4 1026.8 1053.9 1065.2 1072.2 1079.8 11344.1 11689.9 11770.2 11866.1 11961.6 523695.0 528170.0 549489.0 550662.0 554260.0 95700.0 95803.0 96141.0 98880.0 101323.0 1025.5 1058.1 1067.4 1078.1 1079.6 16284.9 18542.7 18638.5 18647.4 19009.4 43481.0 43613.3 43712.3 44901.1 45462.0 61072.4 61121.0 61621.1 61981.4 62637.7 9041.5 9138.5 9260.1 9282.3 9604.5 11555.0 14157.2 14311.5 14316.8 14433.3 12056.2 12119.5 12571.7 12597.1 12831.9 11729.4 12132.4 12318.8 12329.0 12477.8 12649.1 12686.8 12772.4 13009.2 13039.9 9114.4 9332.5 9347.5 9438.2 9577.3 9917.9 12183.5 12505.8 12946.7 12960.7 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | [#3] mootools.html Cycles:180 Average:6435.27 Median:492.92 stddev:3753.65 (761.5%) stddev-sans-first:3746.24 21:15:57 INFO - PROCESS | 9537 | Values: 1552.0 1575.5 1735.8 1835.9 1865.3 8318.3 9186.2 9234.4 9982.0 9996.6 9480.7 9793.7 9795.4 9815.0 9868.3 2463.0 2482.5 2504.7 2509.2 2518.6 2468.4 2539.7 2542.9 2547.2 2548.1 2380.4 2383.5 2495.4 2509.2 2516.2 2395.9 2436.4 2445.0 2457.7 2468.9 2458.3 2462.0 2463.1 2476.4 2477.5 9662.2 9836.1 9851.4 9859.3 9872.1 5594.2 5653.0 5661.0 5715.7 5718.6 3494.9 3587.1 3595.6 3619.1 3688.1 1173.7 1210.7 1224.3 1231.0 1238.1 13847.9 13858.9 13885.8 13917.7 13918.7 4945.2 4960.8 5009.7 5021.5 5210.6 11655.1 11685.2 11698.9 11756.9 11758.9 5701.8 5724.2 5753.5 5759.9 5761.6 4614.3 4993.3 5055.7 5116.4 5257.9 4218.0 4316.0 4351.3 4396.7 4510.6 1365.1 1368.1 1383.8 1388.4 1389.7 949.2 987.5 1059.7 1074.7 1082.8 6500.5 6597.6 6772.0 6781.6 6825.8 481.5 492.6 493.3 494.4 520.7 4621.7 4639.2 4656.7 4709.6 4763.9 11882.7 12203.8 12246.2 12324.4 12361.2 11537.5 12027.0 12298.4 12324.4 12384.2 9036.5 9272.7 9278.8 9299.6 9309.4 6658.9 6732.6 6734.9 6833.6 6929.4 10893.9 11126.3 11302.1 11334.1 11342.7 11452.0 11561.4 11620.8 11645.1 11723.6 8035.2 8567.7 8709.5 8729.2 8965.8 9800.0 9805.5 9824.2 9835.0 9838.9 8555.1 8627.5 8696.0 8744.3 8827.2 8417.0 8467.1 8553.9 8615.8 8627.5 7429.1 7719.0 7768.5 7782.5 7792.5 5786.8 5788.0 5847.7 5861.3 5928.3 5789.6 5799.0 5809.8 5888.3 5904.2 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | [#4] prototype.html Cycles:180 Average:5065.80 Median:5633.16 stddev:1489.87 (26.4%) stddev-sans-first:1451.54 21:15:57 INFO - PROCESS | 9537 | Values: 358.2 360.6 361.7 362.3 366.9 5832.4 5858.4 5881.4 5883.5 5914.9 5590.5 5738.5 5799.6 5802.7 5805.5 4530.5 4567.9 4575.6 4589.1 4593.0 4519.1 4568.9 4587.5 4619.8 4634.6 4458.4 4517.7 4557.8 4583.2 4600.6 4504.3 4504.8 4520.4 4552.9 4575.6 4041.4 4060.3 4070.6 4081.5 4083.9 5580.8 5672.7 5674.1 5680.4 5693.7 5226.3 5234.2 5242.9 5254.2 5266.9 6002.5 6024.2 6090.7 6130.0 6141.7 4290.5 4430.3 4456.9 4487.7 4491.5 5931.6 6117.9 6267.5 6279.2 6299.8 4530.2 4535.8 4550.7 4564.6 4573.7 4558.2 4600.2 4607.0 4621.9 4638.7 4989.3 5177.6 5182.9 5237.7 5241.7 6075.6 6109.6 6115.9 6168.9 6186.8 1554.5 1558.0 1598.5 1601.6 1603.7 968.8 997.8 1001.3 1015.1 1018.9 5182.4 5201.0 5262.4 5271.5 5285.7 5480.8 5491.0 5500.5 5531.1 5542.5 4923.0 5121.9 5162.9 5233.5 5255.6 2868.7 2922.4 2923.4 2930.6 2936.9 5593.6 5710.5 5724.0 5747.7 5753.3 5982.0 6395.5 6405.0 6447.2 6453.3 6508.8 6509.3 6521.5 6527.7 6536.7 6117.3 6251.3 6272.1 6331.8 6340.9 6239.8 6244.9 6246.1 6272.7 6278.6 6180.8 6294.2 6428.6 6455.4 6477.1 4432.4 4443.1 4451.6 4456.8 4469.4 6167.7 6236.8 6314.9 6347.0 6374.0 6129.5 6130.4 6132.7 6158.6 6179.0 5892.3 6093.3 6141.9 6143.4 6189.5 6051.5 6099.7 6102.9 6116.6 6116.8 6155.4 6156.2 6160.8 6165.7 6232.8 5768.5 5973.4 5994.5 6002.8 6016.7 21:15:57 INFO - PROCESS | 9537 | 21:15:57 INFO - PROCESS | 9537 | [#5] yui.html Cycles:180 Average:21892.41 Median:4837.57 stddev:31849.03 (658.4%) stddev-sans-first:31898.92 21:15:57 INFO - PROCESS | 9537 | Values: 778.6 788.5 801.4 824.3 871.3 16419.3 16964.5 17186.8 17228.4 17325.6 16016.5 16197.0 16220.7 16221.4 16222.8 712.6 823.1 850.8 864.2 871.3 853.2 854.3 859.7 859.9 862.6 918.7 918.9 921.1 921.5 921.8 899.8 907.8 909.5 913.4 913.9 674.4 674.5 674.8 678.1 681.3 16164.1 16189.7 16207.4 16215.2 16329.3 13807.9 13866.9 13886.4 13906.0 14019.1 14159.4 14185.8 14219.3 14451.3 14584.1 4641.3 4650.7 4683.0 4704.1 4712.8 87323.1 88590.0 88594.6 88886.1 88913.1 10639.1 10949.3 11022.3 11074.4 11074.7 21083.6 21169.9 21178.0 21184.7 21222.2 8875.9 9062.7 9095.2 9140.4 9191.1 5131.6 5160.1 5206.5 5300.9 5372.2 3778.9 3902.8 3920.7 3928.6 3942.6 665.6 678.3 685.4 693.5 698.4 655.7 660.0 685.3 691.4 714.0 8897.5 9024.0 9545.5 9732.6 10138.7 608.6 652.7 674.0 677.4 709.9 4626.3 4826.4 4848.8 4867.8 4944.5 70940.6 75475.6 91878.1 134915.3 141628.0 64824.7 74273.3 115101.0 115610.4 116842.4 63019.0 97059.5 102873.5 106180.0 106850.0 9616.6 9784.9 9846.1 9870.7 9949.2 59192.7 59365.7 59953.0 61195.7 61767.0 84831.6 89056.6 89132.0 89624.0 93025.5 12266.2 12493.3 12573.2 12664.9 12714.9 13663.4 13687.3 13995.3 14055.9 14090.5 11703.8 11758.4 11914.9 12157.3 12371.8 14305.9 14499.1 14518.2 14656.2 16396.7 13753.3 14198.3 14492.3 14651.6 15127.5 10864.2 11461.3 11655.8 11910.4 12261.5 10969.2 11621.2 11755.8 11808.9 11823.1 21:15:57 INFO - PROCESS | 9537 | -------- Summary: end -------- 21:15:57 INFO - PROCESS | 9537 | 21:15:58 INFO - TEST-INFO | 9537: exit 0 21:15:58 INFO - TEST-OK | dromaeo_css | took 1110700ms 21:15:58 INFO - TEST-START | kraken 21:15:58 INFO - operating with platform_type : linux_ 21:15:58 INFO - Initialising browser for kraken test... 21:15:58 INFO - TEST-INFO | started process 9804 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeT0NrA/profile http://localhost:47606/getInfo.html) 21:16:02 INFO - PROCESS | 9804 | __metrics Screen width/height:1600/1200 21:16:02 INFO - PROCESS | 9804 | colorDepth:24 21:16:02 INFO - PROCESS | 9804 | Browser inner width/height: 1024/697 21:16:02 INFO - PROCESS | 9804 | __metrics 21:16:03 ERROR - PROCESS | 9804 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:16:03 INFO - TEST-INFO | 9804: exit 0 21:16:03 INFO - Browser initialized. 21:16:03 INFO - Running cycle 1/1 for kraken test... 21:16:03 INFO - TEST-INFO | started process 9929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeT0NrA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:15 INFO - PROCESS | 9929 | RSS: Main: 153280512 21:16:15 INFO - PROCESS | 9929 | 21:16:18 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47606/tests/kraken/driver.html?testName=audio-beat-detection) 21:16:19 INFO - PROCESS | 9929 | RSS: Main: 158633984 21:16:19 INFO - PROCESS | 9929 | 21:16:21 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47606/tests/kraken/driver.html?testName=audio-dft) 21:16:22 INFO - PROCESS | 9929 | RSS: Main: 157417472 21:16:22 INFO - PROCESS | 9929 | 21:16:25 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47606/tests/kraken/driver.html?testName=audio-fft) 21:16:25 INFO - PROCESS | 9929 | RSS: Main: 157945856 21:16:25 INFO - PROCESS | 9929 | 21:16:28 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47606/tests/kraken/driver.html?testName=audio-oscillator) 21:16:28 INFO - PROCESS | 9929 | RSS: Main: 157298688 21:16:28 INFO - PROCESS | 9929 | 21:16:30 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:16:31 INFO - PROCESS | 9929 | RSS: Main: 157696000 21:16:31 INFO - PROCESS | 9929 | 21:16:34 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47606/tests/kraken/driver.html?testName=imaging-darkroom) 21:16:35 INFO - PROCESS | 9929 | RSS: Main: 158011392 21:16:35 INFO - PROCESS | 9929 | 21:16:38 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47606/tests/kraken/driver.html?testName=imaging-desaturate) 21:16:39 INFO - PROCESS | 9929 | RSS: Main: 157638656 21:16:39 INFO - PROCESS | 9929 | 21:16:42 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47606/tests/kraken/driver.html?testName=json-parse-financial) 21:16:42 INFO - PROCESS | 9929 | RSS: Main: 158126080 21:16:42 INFO - PROCESS | 9929 | 21:16:44 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:44 INFO - PROCESS | 9929 | RSS: Main: 158003200 21:16:44 INFO - PROCESS | 9929 | 21:16:46 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:47 INFO - PROCESS | 9929 | RSS: Main: 157937664 21:16:47 INFO - PROCESS | 9929 | 21:16:49 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:49 INFO - PROCESS | 9929 | RSS: Main: 158314496 21:16:49 INFO - PROCESS | 9929 | 21:16:52 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:53 INFO - PROCESS | 9929 | RSS: Main: 158887936 21:16:53 INFO - PROCESS | 9929 | 21:16:55 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:56 INFO - PROCESS | 9929 | RSS: Main: 158756864 21:16:56 INFO - PROCESS | 9929 | 21:16:57 INFO - PROCESS | 9929 | Cycle 1(1): loaded http://localhost:47606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47606/tests/kraken/driver.html?testName=ai-astar) 21:16:58 INFO - PROCESS | 9929 | RSS: Main: 160747520 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | __start_tp_report 21:16:58 INFO - PROCESS | 9929 | _x_x_mozilla_page_load 21:16:58 INFO - PROCESS | 9929 | _x_x_mozilla_page_load_details 21:16:58 INFO - PROCESS | 9929 | |i|pagename|runs| 21:16:58 INFO - PROCESS | 9929 | |0;ai-astar;102;111;113;107;110;111;110;111;110;120 21:16:58 INFO - PROCESS | 9929 | |1;audio-beat-detection;146;116;147;171;121;145;143;124;176;120 21:16:58 INFO - PROCESS | 9929 | |2;audio-dft;161;162;162;164;162;162;161;164;162;161 21:16:58 INFO - PROCESS | 9929 | |3;audio-fft;75;75;76;187;79;77;74;75;169;75 21:16:58 INFO - PROCESS | 9929 | |4;audio-oscillator;84;85;138;84;83;83;134;82;84;151 21:16:58 INFO - PROCESS | 9929 | |5;imaging-gaussian-blur;117;118;118;118;118;117;117;118;118;117 21:16:58 INFO - PROCESS | 9929 | |6;imaging-darkroom;147;147;147;146;147;147;147;147;147;147 21:16:58 INFO - PROCESS | 9929 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;95;94 21:16:58 INFO - PROCESS | 9929 | |8;json-parse-financial;51;53;52;52;52;52;52;51;50;53 21:16:58 INFO - PROCESS | 9929 | |9;json-stringify-tinderbox;59;59;60;60;64;59;60;59;60;60 21:16:58 INFO - PROCESS | 9929 | |10;stanford-crypto-aes;76;82;72;74;74;72;82;80;76;80 21:16:58 INFO - PROCESS | 9929 | |11;stanford-crypto-ccm;124;117;118;118;127;120;117;133;148;140 21:16:58 INFO - PROCESS | 9929 | |12;stanford-crypto-pbkdf2;149;151;150;156;151;150;151;148;150;151 21:16:58 INFO - PROCESS | 9929 | |13;stanford-crypto-sha256-iterative;62;65;66;62;62;62;60;65;60;62 21:16:58 INFO - PROCESS | 9929 | __end_tp_report 21:16:58 INFO - PROCESS | 9929 | __start_cc_report 21:16:58 INFO - PROCESS | 9929 | _x_x_mozilla_cycle_collect,918 21:16:58 INFO - PROCESS | 9929 | __end_cc_report 21:16:58 INFO - PROCESS | 9929 | __startTimestamp1473826618197__endTimestamp 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | ------- Summary: start ------- 21:16:58 INFO - PROCESS | 9929 | Number of tests: 14 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:4.50 (4.1%) stddev-sans-first:3.57 21:16:58 INFO - PROCESS | 9929 | Values: 102.0 111.0 113.0 107.0 110.0 111.0 110.0 111.0 110.0 120.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:145.50 stddev:20.98 (14.4%) stddev-sans-first:22.17 21:16:58 INFO - PROCESS | 9929 | Values: 146.0 116.0 147.0 171.0 121.0 145.0 143.0 124.0 176.0 120.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 21:16:58 INFO - PROCESS | 9929 | Values: 161.0 162.0 162.0 164.0 162.0 162.0 161.0 164.0 162.0 161.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#3] audio-fft Cycles:10 Average:96.20 Median:75.00 stddev:43.34 (57.8%) stddev-sans-first:45.29 21:16:58 INFO - PROCESS | 9929 | Values: 75.0 75.0 76.0 187.0 79.0 77.0 74.0 75.0 169.0 75.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:83.50 stddev:28.07 (33.6%) stddev-sans-first:29.10 21:16:58 INFO - PROCESS | 9929 | Values: 84.0 85.0 138.0 84.0 83.0 83.0 134.0 82.0 84.0 151.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:16:58 INFO - PROCESS | 9929 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 21:16:58 INFO - PROCESS | 9929 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:16:58 INFO - PROCESS | 9929 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 94.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.93 21:16:58 INFO - PROCESS | 9929 | Values: 51.0 53.0 52.0 52.0 52.0 52.0 52.0 51.0 50.0 53.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.49 (2.5%) stddev-sans-first:1.54 21:16:58 INFO - PROCESS | 9929 | Values: 59.0 59.0 60.0 60.0 64.0 59.0 60.0 59.0 60.0 60.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:78.00 stddev:3.91 (5.0%) stddev-sans-first:4.14 21:16:58 INFO - PROCESS | 9929 | Values: 76.0 82.0 72.0 74.0 74.0 72.0 82.0 80.0 76.0 80.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:125.50 stddev:10.85 (8.6%) stddev-sans-first:11.48 21:16:58 INFO - PROCESS | 9929 | Values: 124.0 117.0 118.0 118.0 127.0 120.0 117.0 133.0 148.0 140.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:151.00 stddev:2.11 (1.4%) stddev-sans-first:2.15 21:16:58 INFO - PROCESS | 9929 | Values: 149.0 151.0 150.0 156.0 151.0 150.0 151.0 148.0 150.0 151.0 21:16:58 INFO - PROCESS | 9929 | 21:16:58 INFO - PROCESS | 9929 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:2.07 (3.3%) stddev-sans-first:2.18 21:16:58 INFO - PROCESS | 9929 | Values: 62.0 65.0 66.0 62.0 62.0 62.0 60.0 65.0 60.0 62.0 21:16:58 INFO - PROCESS | 9929 | -------- Summary: end -------- 21:16:58 INFO - PROCESS | 9929 | 21:16:59 INFO - TEST-INFO | 9929: exit 0 21:16:59 INFO - TEST-OK | kraken | took 61091ms 21:16:59 INFO - SUITE-END | took 1171s 21:16:59 INFO - Completed test suite (00:19:31) 21:16:59 INFO - javascript benchmark 21:16:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7652.735517859127, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.6896644818744, 3275.39405210036, 3288.4738441849295, 3290.459758095438, 3311.1556553078976, 5649.180868774025, 5699.173619825123, 5699.344575373833, 5700.80283140541, 5705.4294570542925, 5645.576581756364, 5676.403977582346, 5690.231818704484, 5705.6006079574345, 5724.4561766632205, 5160.458151894053, 5183.688978661293, 5213.869653258661, 5260.868478288055, 5287.312649355597, 4984.601231901439, 4997.4003119625695, 5008.899822003557, 5017.071841709278, 5085.415177254626, 5162.199859021839, 5183.403908550527, 5195.870103247411, 5197.818076367328, 5238.52853243208, 5201.115810312256, 5205.479452054802, 5220.530152286275, 5228.92156617651, 5258.50044245796, 4894.608431325485, 4954.925676114861, 4970.950290497121, 5116.872078198075, 5137.768800403991, 5462.0987537056335, 5503.422140675251, 5503.6147469677135, 5512.531434828044, 5551.805686800943, 5868.941310586925, 5869.1196320551835, 5905.852353691149, 5919.496842768327, 5922.200502932092, 5781.046127388976, 5905.940940590582, 5941.524678025748, 5943.881122377528, 5953.821385358447, 5596.636218645775, 5612.382637909826, 5617.719114044281, 5633.915491267634, 5643.1535269709875, 6066.939330606726, 6085.756569737161, 6101.694915254219, 6116.908246376308, 6118.816435506942, 5712.714364281769, 5840.977828879929, 5852.502537284378, 5889.352171261158, 5894.823155305347, 6052.969735151384, 6055.303640081359, 6080.209572755513, 6095.268567771807, 6098.420650038239, 5980.85047873798, 6010.9699451502465, 6019.849503762441, 6050.909236361458, 6051.757929682852, 5723.427657234327, 5916.940830591725, 5932.584719069624, 5958.255218097738, 6048.788292409745, 4598.632109431237, 4613.792379342937, 4628.421447319085, 4646.883827904329, 4655.976720116378, 4122.628963393309, 4132.049628585382, 4140.648044916215, 4142.544320124784, 4169.124483858363, 5588.329400471969, 5612.803551875746, 5650.660960342392, 5836.533077353802, 5842.5618078644275, 6002.789902353396, 6007.189029481052, 6012.669303188367, 6024.277086749618, 6047.606905551125, 5656.236408084938, 5702.173184888251, 5743.339515955635, 5744.052231381859, 5748.39641837601, 5026.045051440215, 5152.407473140637, 5161.174212126042, 5177.896442071137, 5199.4540573239265, 6209.0, 6232.875342493125, 6252.030935205051, 6258.405451482102, 6260.217472815898, 6033.728482218223, 6039.365866583946, 6049.062395328643, 6052.636841789506, 6061.909071364022, 5988.041913293852, 6039.607425517327, 6068.757249710139, 6141.8464538385115, 6144.354842741448, 5776.826695199151, 5812.564057695605, 5813.854653633693, 5814.5639077068545, 5824.912626310524, 5908.468237858613, 5913.940860591339, 5924.526037917042, 5931.110333449845, 5936.970315148396, 5595.104783234663, 5794.855128621818, 5844.590878638454, 5875.471207591338, 5931.673757943182, 5860.648361098348, 5867.413258674099, 5867.471927526543, 5870.5010074142465, 5884.146798714077, 5812.476877081083, 5859.121131830259, 5867.853303667443, 5870.5010074142465, 5883.852903677443, 5698.857528561653, 5717.971410142923, 5773.826785196451, 5869.765209391577, 5961.135635332766, 5765.56758243125, 5767.769289228384, 5792.768289268382, 5812.21535092757, 5821.505172060253], "value": 5529.985734344084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.1864664056882, 645.5029627187065, 655.786869267488, 668.8361351468891, 722.1839321566629, 40347.193056138894, 43991.0, 44267.55732442674, 44277.114457710864, 44397.556024439786, 45826.0, 46140.76929615356, 46306.30540541895, 46401.53598464014, 46527.76736116315, 8950.86573701395, 9057.320700947423, 9094.363394562382, 9102.22631076356, 9142.085791420872, 9005.954970225172, 9098.86351704725, 9112.772180695469, 9127.543622818866, 9129.087091290885, 9055.683051093212, 9116.589753461078, 9135.451872887648, 9138.268938484938, 9148.771280717969, 9146.908530914705, 9229.953850230739, 9246.12161844627, 9254.259659227313, 9258.120478554527, 9064.274858011344, 9110.954445227797, 9117.0, 9124.771880703036, 9135.40619859707, 43025.56974430247, 43151.13697726059, 43276.567234327566, 43326.0, 43370.34944475835, 3783.6973042156837, 3870.59358767331, 3976.8608098716695, 4058.959410405888, 4685.8594242172785, 34184.31631367359, 34218.0, 34371.0, 34923.1269218269, 35813.28373432517, 4177.644900183488, 4179.791010449496, 4195.832166713328, 4216.3464662977285, 4250.383694364331, 257077.0, 257477.0, 259694.0, 260322.0, 261545.0, 38454.80772596119, 39713.60286397099, 60659.69670151621, 60802.8718994833, 61274.69362653158, 40425.595744042184, 40673.593264067575, 40760.18479630391, 40829.79585102056, 40860.591394086274, 17269.13654317279, 17425.0, 17439.389621363192, 17441.7383739244, 17448.563785905455, 14241.145531268157, 14298.714025719428, 14335.211563363906, 14414.207218603078, 14430.639234019234, 9125.954370228239, 9141.634334626673, 9235.076492350845, 9240.122188392092, 9293.814123717488, 3474.409350410436, 3598.1184609770776, 3620.71034317254, 3663.9633603664156, 3685.0603096210293, 1065.5524679634573, 1080.303204433152, 1129.2490493821517, 1134.1550544843979, 1205.3306170953117, 32627.83686081602, 33153.66846331506, 33261.50107748386, 33765.83117084399, 34045.489317660256, 1169.7952858249773, 1229.3668760588125, 1249.3940438887132, 1272.5291642092484, 1293.9158954667917, 16983.660326793393, 17562.912185438992, 17661.38185163513, 17777.288908443777, 17786.401970296498, 583273.0, 625053.0, 626409.0, 635452.0, 943800.0, 64475.0, 65313.0, 65491.34508654852, 65620.67189664021, 65909.0, 1467.288365142905, 1485.0718301061836, 1497.3561368611602, 1518.3546992528131, 1527.0913806285243, 34274.657253428144, 34421.0, 35301.646983529834, 35365.0, 35459.11352216215, 54064.189037163684, 54666.72666636641, 54802.45197547974, 54882.72558637181, 54978.45021549733, 548589.0, 550521.0, 551284.0, 552359.0, 553321.0, 30742.846285768428, 31312.843435782674, 31345.373092537564, 31739.841300794273, 31780.841095794374, 52132.73933630308, 52450.213246800566, 52598.47401526089, 53070.73464632806, 53153.46846531485, 43574.346384804885, 43931.78034109809, 44899.10201796011, 45623.31565026593, 46333.30500042435, 44676.0, 44862.775686122666, 45329.320060198464, 46192.76903615595, 46194.53805462037, 43809.56190438055, 44055.559444406426, 44098.77950610226, 44453.555464444944, 44967.55032449764, 38945.22109557736, 39725.404118938815, 39749.84502789526, 40113.598864010986, 40184.1963160741, 30191.849040754656, 30311.848440757654, 30639.693603064577, 30760.846195768878, 31300.686993129777], "value": 20227.7426007954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.2116710001646, 426.73115936959715, 432.4702239756297, 433.5642679107497, 448.5245639622001, 19349.419517414466, 20272.89863550682, 20761.584768304623, 20798.272060477888, 20933.74397536147, 19303.13135908884, 20687.896560517176, 20899.68650470244, 21207.0, 21235.469113272175, 5931.199288096116, 6144.723487443076, 6147.907781383283, 6149.169862068608, 6153.230846144232, 5935.88128237435, 6042.9395706042815, 6079.848003799918, 6085.208922840025, 6086.482648974842, 5732.369439361667, 5874.73563689635, 5951.791687290945, 6010.218671572689, 6051.727672254759, 5899.292084949812, 5931.584789064767, 5985.132155837401, 6033.728482218311, 6050.515958723292, 5353.4646535346155, 5360.544353729938, 5428.891422171534, 5447.073997420448, 5447.509724124848, 24402.0, 24443.755562444505, 24582.262532124067, 24854.502909941883, 25033.4993300133, 2571.370014346497, 2599.584066549362, 2677.397585543257, 2686.1672881406826, 2694.097477345072, 15805.130717810516, 15925.522234332988, 15935.123568203744, 16233.0, 16447.342106315733, 2080.4382816639422, 2091.6444204485274, 2119.501917049492, 2177.194438057913, 2193.8793366364844, 83481.58259208726, 83540.58229708874, 85023.57488212582, 85653.0, 87806.5609671954, 9836.06557377048, 10444.321119127233, 10501.054905058581, 10575.841362379571, 10830.133589312836, 14673.119612823264, 14713.0, 14718.484853030093, 14721.116732996055, 14749.115053096848, 8495.192956669107, 8632.697855575025, 8676.8698469523, 8679.826403472021, 8738.082501337396, 8780.692675756318, 8804.383693141546, 8835.20483156506, 8994.145556172152, 9011.23404510624, 4503.617192538605, 4513.819447222074, 4515.616172625298, 4524.6380289576755, 4581.94615238497, 2078.7089807426973, 2083.7186979757844, 2089.3000844716885, 2121.7666056733747, 2202.9709149918863, 938.9859152112724, 1025.4257615735212, 1039.5010395010286, 1047.7275908263907, 1132.9859775500881, 20667.689984650242, 20977.89511052435, 21326.466838329165, 21351.893240533696, 21448.356549303546, 1026.7895081508423, 1053.9367637941748, 1065.158524765442, 1072.2119242356862, 1079.83262594298, 11344.149188810707, 11689.883101169049, 11770.234934729215, 11866.110041746904, 11961.64115076549, 523695.0, 528170.0, 549489.0, 550662.0, 554260.0, 95700.0, 95803.0, 96141.0, 98880.0, 101323.0, 1025.5231317437429, 1058.0953284941418, 1067.4075887882145, 1078.0890147825075, 1079.5735684404774, 16284.918575407048, 18542.721859171852, 18638.53403664919, 18647.44057678272, 19009.42971710851, 43481.0, 43613.34579981239, 43712.34431483466, 44901.1019779596, 45462.0, 61072.38927610845, 61121.0, 61621.075683865674, 61981.38018619936, 62637.68681156565, 9041.502717350346, 9138.497382644018, 9260.120288572574, 9282.303827213122, 9604.471754053595, 11555.0, 14157.221352825281, 14311.499097531536, 14316.785248221076, 14433.278336082943, 12056.156069075432, 12119.515219391125, 12571.68570785701, 12597.11820172579, 12831.946888497796, 11729.413529323328, 12132.393380330772, 12318.815217771562, 12329.0, 12477.75044499123, 12649.051321150766, 12686.809697854354, 12772.361381931052, 13009.154404963647, 13039.934800325938, 9114.3559836968, 9332.53337333117, 9347.485888276211, 9438.150566448778, 9577.281703872099, 9917.900820991697, 12183.512659493521, 12505.812412813997, 12946.676333091747, 12960.740785184054], "value": 9856.879623354513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.9922400388, 1575.5037163293562, 1735.8437740603342, 1835.8714889957707, 1865.2725437079532, 8318.251357377834, 9186.173244408003, 9234.445933244002, 9982.0, 9996.550155243005, 9480.715578532656, 9793.706188814329, 9795.363301385423, 9814.950925245364, 9868.3092183547, 2462.975370246297, 2482.503499300138, 2504.724480307174, 2509.2221411362443, 2518.5718427867305, 2468.419921318489, 2539.6571462852557, 2542.8982840686444, 2547.197632745688, 2548.1336345642476, 2380.3573035280465, 2383.4994651123284, 2495.36368226103, 2509.1970569417795, 2516.169664010872, 2395.940101497459, 2436.3665446983823, 2445.0342114864616, 2457.680501534807, 2468.8642124683133, 2458.262521243638, 2461.963070553943, 2463.1255904153945, 2476.430421003179, 2477.5416547938507, 9662.17871480925, 9836.114749672564, 9851.408915465096, 9859.260555458297, 9872.062154095349, 5594.216809646653, 5652.954203472371, 5660.981023415784, 5715.685637289947, 5718.59969802114, 3494.947575786365, 3587.1390866191928, 3595.5865075516126, 3619.077135330474, 3688.133288677159, 1173.6537721372215, 1210.7457433938882, 1224.3449754381363, 1230.95076196952, 1238.102375777554, 13847.930760346235, 13858.861411385958, 13885.791713124312, 13917.721645567031, 13918.652033699138, 4945.159322915041, 4960.801567937242, 5009.674371165863, 5021.5229553192385, 5210.557102646318, 11655.067594592412, 11685.240459370283, 11698.947094761343, 11756.882431175749, 11758.941205293919, 5701.800436984686, 5724.227229323988, 5753.482186603226, 5759.884802303931, 5761.625494342854, 4614.2617181250835, 4993.325901003318, 5055.747212639353, 5116.411612664517, 5257.947420525822, 4217.957820421818, 4316.0, 4351.26028575143, 4396.736195828196, 4510.639148868083, 1365.0717512091674, 1368.1312366647053, 1383.75784237758, 1388.430743395203, 1389.6595334142999, 949.1599934058409, 987.456898705709, 1059.692689120162, 1074.6937122920087, 1082.7509672775147, 6500.544961852719, 6597.60414375139, 6771.966140169267, 6781.62701051437, 6825.795226143224, 481.5092552393752, 492.5591595522059, 493.27488591770043, 494.4091810286745, 520.6901893373437, 4621.676482646182, 4639.188142075123, 4656.674032817738, 4709.576138147583, 4763.928541071887, 11882.702932426759, 12203.816942745865, 12246.203996740362, 12324.383780810924, 12361.196522226026, 11537.538498459968, 12027.03783697302, 12298.385080745928, 12324.383780810924, 12384.195027323376, 9036.548172591343, 9272.67545635913, 9278.814423711623, 9299.628014879465, 9309.44143351401, 6658.933410665832, 6732.629705366252, 6734.9326506734305, 6833.58998460094, 6929.44564434834, 10893.891061089606, 11126.276792008493, 11302.095832333229, 11334.14993875446, 11342.659720208407, 11452.0, 11561.42192890369, 11620.825687614524, 11645.126615504041, 11723.589674361356, 8035.156308587748, 8567.657293708182, 8709.520976346108, 8729.170728780755, 8965.820683586422, 9799.951000244953, 9805.509724513604, 9824.214062875095, 9834.950825245827, 9838.9016109838, 8555.144485551395, 8627.482351058956, 8696.043435221995, 8744.300455963381, 8827.205551500396, 8416.957915210385, 8467.11095334981, 8553.914460855312, 8615.827683446421, 8627.482351058956, 7429.108506978981, 7718.961405192938, 7768.456208065381, 7782.533048017137, 7792.493487923267, 5786.768529258782, 5787.987102257004, 5847.707614619167, 5861.296644402699, 5928.288605367384, 5789.623674461147, 5799.043157878903, 5809.76760929575, 5888.263967004124, 5904.202932604044], "value": 5012.784780079311, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.19227641668044, 360.56551855014703, 361.68533375962915, 362.2573723866075, 366.88443140410766, 5832.445917637829, 5858.384869588695, 5881.441263080006, 5883.499902508292, 5914.905742437652, 5590.496855283024, 5738.512226460745, 5799.56503262256, 5802.709864506779, 5805.477507024367, 4530.501644819067, 4567.931481027771, 4575.565321294472, 4589.128065667529, 4592.954070459303, 4519.050999290153, 4568.885777855564, 4587.518310577391, 4619.766163685417, 4634.629229661619, 4458.375827384152, 4517.661175411841, 4557.794899229526, 4583.19794036044, 4600.562946520092, 4504.324351347292, 4504.842330518432, 4520.367148599199, 4552.8861778455475, 4575.611073058761, 4041.4139949707424, 4060.330045542482, 4070.5725898780793, 4081.4898137732785, 4083.9183216335505, 5580.776768929238, 5672.716364181774, 5674.120511320752, 5680.375158732536, 5693.686847223401, 5226.268322434862, 5234.162533994542, 5242.9213561796605, 5254.21186821976, 5266.894662106774, 6002.459778619946, 6024.246969128859, 6090.725917333686, 6129.969350153266, 6141.679538899158, 4290.549492303326, 4430.335449682541, 4456.866294011184, 4487.685861989662, 4491.461024677027, 5931.6144450611, 6117.877642447126, 6267.4672652824565, 6279.215098112736, 6299.779507717208, 4530.161920044737, 4535.818567257273, 4550.726956382628, 4564.566366195206, 4573.748443835621, 4558.156741002925, 4600.228911868888, 4607.0, 4621.930671039937, 4638.744869032235, 4989.301497790312, 5177.559907407913, 5182.870428239249, 5237.711925844039, 5241.746049198881, 6075.574709770273, 6109.633421994606, 6115.877682446326, 6168.8766224675255, 6186.81439556814, 1554.518099389193, 1557.9950931649023, 1598.4884836852327, 1601.6316247263194, 1603.7193491139003, 968.801395713877, 997.8154041502345, 1001.2590682894605, 1015.1269907879218, 1018.8792328438658, 5182.352205974254, 5200.97399513, 5262.368515778055, 5271.499207575274, 5285.652158699584, 5480.7533660985355, 5490.972545137249, 5500.477454641803, 5531.059719847635, 5542.501174894279, 4922.9753851231235, 5121.948780512147, 5162.8967420652125, 5233.450487698737, 5255.6321057526375, 2868.7234180789346, 2922.4072880279873, 2923.444545536384, 2930.6190195274903, 2936.900116416772, 5593.608447408724, 5710.543156547466, 5724.0, 5747.706765977621, 5753.252077229933, 5981.970090149608, 6395.52033597482, 6405.0, 6447.2263328400895, 6453.257875344396, 6508.754479704495, 6509.251436084911, 6521.47828173745, 6527.738890444329, 6536.705848236841, 6117.296510901303, 6251.281102673069, 6272.121902933684, 6331.841703957438, 6340.904886426615, 6239.812805615838, 6244.937550624617, 6246.0955655620355, 6272.717727702173, 6278.560500765086, 6180.845478863064, 6294.15028971083, 6428.582142160744, 6455.354464553695, 6477.125588045554, 4432.423784907941, 4443.133588950253, 4451.554844515523, 4456.821727130879, 4469.396631454712, 6167.722452489559, 6236.844078898064, 6314.905276420765, 6346.9682651586445, 6374.0, 6129.540284478593, 6130.356312587292, 6132.657701552754, 6158.630482171084, 6179.0, 5892.292924849045, 6093.268807742922, 6141.877162456815, 6143.447089761943, 6189.473894718999, 6051.4553690168095, 6099.695015249308, 6102.938970610237, 6116.633002019893, 6116.816495505142, 6155.415235552616, 6156.199694039746, 6160.784372546939, 6165.749501432035, 6232.844178895564, 5768.480836724715, 5973.432523910222, 5994.460498555151, 6002.789902353396, 6016.699165041818], "value": 4589.813635434508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.5601135358522, 788.5254573946719, 801.3909428834086, 824.3240542754943, 871.298604623278, 16419.261133249, 16964.49106526803, 17186.828131718677, 17228.39700610476, 17325.56686082847, 16016.519504414886, 16196.99999999997, 16220.675586488263, 16221.432249871257, 16222.7566586501, 712.6151877985882, 823.0987069159261, 850.8085680721819, 864.1660797330575, 871.3421366868038, 853.185208126241, 854.2525290370926, 859.7119964811795, 859.896812382515, 862.6118246788939, 918.6922381002372, 918.8759517465157, 921.0835218957147, 921.5023887100957, 921.8340698674236, 899.7840518275599, 907.795745957161, 909.4815954905706, 913.3606475467167, 913.8720579118929, 674.43684523423, 674.4705406256114, 674.8245456181379, 678.1421501800227, 681.2914568848391, 16164.110973896431, 16189.676206475922, 16207.432739854166, 16215.189240537926, 16329.265183066791, 13807.861921380758, 13866.861331386759, 13886.375113119933, 13906.0, 14019.088759230617, 14159.362828672734, 14185.848930049593, 14219.289035548285, 14451.349689264009, 14584.124952502883, 4641.257398816173, 4650.7442090685, 4682.953170468286, 4704.1062198182235, 4712.835050773207, 87323.12676873214, 88590.02212433492, 88594.5570272151, 88886.11113888843, 88913.11086889177, 10639.095676867399, 10949.288296260876, 11022.338659680445, 11074.39090850011, 11074.723131921604, 21083.578328433654, 21169.894150529148, 21178.0, 21184.682229766568, 21222.151113955577, 8875.866861996947, 9062.682806101755, 9095.181433671001, 9140.360174787702, 9191.080891910755, 5131.640785145004, 5160.0969830279555, 5206.5314121729225, 5300.893982120336, 5372.1941708744, 3778.905527361783, 3902.785346805896, 3920.7059470539825, 3928.626780455852, 3942.56631770505, 665.6339013542532, 678.3420082519948, 685.4482141875837, 693.4764252988961, 698.3923986131996, 655.7114869457423, 659.9901001484982, 685.2599192871786, 691.4399336537421, 713.9607321597258, 8897.466152030898, 9023.954880225558, 9545.474998875128, 9732.610695572239, 10138.746531336628, 608.592243197059, 652.7291174162764, 673.9696713647897, 677.4005005570008, 709.8899670551073, 4626.259798432235, 4826.356205102799, 4848.781804818792, 4867.805287788519, 4944.505549445099, 70940.64529677422, 75475.62262188653, 91878.08121918695, 134915.32542337422, 141628.0, 64824.67587662126, 74273.25726742664, 115101.0, 115610.42194788973, 116842.41578792052, 63019.0, 97059.51470242745, 102873.48563257286, 106180.0, 106850.0, 9616.615335386507, 9784.85322720174, 9846.113849753556, 9870.654527091518, 9949.204063674744, 59192.70403647954, 59365.70317148387, 59953.0, 61195.694021529605, 61767.0, 84831.57584212287, 89056.554717226, 89132.0, 89624.0, 93025.53487232521, 12266.202696824677, 12493.25040497573, 12573.182743121668, 12664.936675316932, 12714.872851271739, 13663.385147668578, 13687.31563421805, 13995.300234988414, 14055.859441405455, 14090.506832261231, 11703.76592468129, 11758.412079396167, 11914.940425297818, 12157.27056376585, 12371.75256494883, 14305.856941430453, 14499.130052196902, 14518.201498917238, 14656.193909334663, 16396.67206655884, 13753.312334383041, 14198.29008549589, 14492.347844347241, 14651.633709157357, 15127.470538531099, 10864.239503234698, 11461.25501842411, 11655.825162622737, 11910.404479776149, 12261.509539618315, 10969.23215374916, 11621.24461909973, 11755.823662645238, 11808.87677110799, 11823.113266504875], "value": 7917.272005201764, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 107.0, 110.0, 111.0, 110.0, 111.0, 110.0, 120.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 147.0, 171.0, 121.0, 145.0, 143.0, 124.0, 176.0, 120.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 164.0, 162.0, 162.0, 161.0, 164.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 187.0, 79.0, 77.0, 74.0, 75.0, 169.0, 75.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 138.0, 84.0, 83.0, 83.0, 134.0, 82.0, 84.0, 151.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 51.0, 50.0, 53.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 64.0, 59.0, 60.0, 59.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 72.0, 74.0, 74.0, 72.0, 82.0, 80.0, 76.0, 80.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 118.0, 118.0, 127.0, 120.0, 117.0, 133.0, 148.0, 140.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 156.0, 151.0, 150.0, 151.0, 148.0, 150.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 66.0, 62.0, 62.0, 62.0, 60.0, 65.0, 60.0, 62.0], "value": 62.6, "unit": "score"}]}]} 21:16:59 INFO - Return code: 0 21:16:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:16:59 ERROR - # TBPL SUCCESS # 21:16:59 INFO - Running post-action listener: _resource_record_post_action 21:16:59 INFO - [mozharness: 2016-09-14 04:16:59.522329Z] Finished run-tests step (success) 21:16:59 INFO - Running post-run listener: _resource_record_post_run 21:16:59 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 327729152; Read time: 48; Write time: 338784 21:16:59 INFO - TinderboxPrint: CPU usage
13.2% 21:16:59 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 48 21:16:59 INFO - TinderboxPrint: I/O write bytes / time
327,729,152 / 338,784 21:16:59 INFO - TinderboxPrint: CPU idle
8,229.2 (86.7%) 21:16:59 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 21:16:59 INFO - TinderboxPrint: Swap in / out
0 / 0 21:16:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79343616; Read time: 0; Write time: 67900 21:16:59 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248037376; Read time: 28; Write time: 270884 21:17:00 INFO - Running post-run listener: _upload_blobber_files 21:17:00 INFO - Blob upload gear active. 21:17:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:17:00 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 21:17:00 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'] 21:17:00 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 21:17:00 INFO - (blobuploader) - INFO - Open directory for files ... 21:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:01 INFO - (blobuploader) - INFO - Done attempting. 21:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:02 INFO - (blobuploader) - INFO - Done attempting. 21:17:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:06 INFO - (blobuploader) - INFO - Done attempting. 21:17:06 INFO - (blobuploader) - INFO - Iteration through files over. 21:17:06 INFO - Return code: 0 21:17:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:17:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:17:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adcea60a70320bb6460795eca6216dec7b7d17c62dd38068b5c668bb93d2c718aa20e998edfa3facd57e4f677edefc9f78ff55cd92687257f1cd8b848a123eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46537859c29fcca56d8f10bf6f49d0743c24699a7422b0f1f3597435ffdfef9ab5bbb9902e27b53bbdec39d7f9805a455fa87848390d6af52c75c4dd241e7d40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d4fb4f6f5dfe8a675ed557d967694593af7f9af8b192e3f761ce2fafcc328490e7b99783a4df7d2589b260b859c16d37206fbc09c9cf67a073371986029d05"} 21:17:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:17:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:17:06 INFO - Contents: 21:17:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adcea60a70320bb6460795eca6216dec7b7d17c62dd38068b5c668bb93d2c718aa20e998edfa3facd57e4f677edefc9f78ff55cd92687257f1cd8b848a123eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46537859c29fcca56d8f10bf6f49d0743c24699a7422b0f1f3597435ffdfef9ab5bbb9902e27b53bbdec39d7f9805a455fa87848390d6af52c75c4dd241e7d40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d4fb4f6f5dfe8a675ed557d967694593af7f9af8b192e3f761ce2fafcc328490e7b99783a4df7d2589b260b859c16d37206fbc09c9cf67a073371986029d05"} 21:17:06 INFO - Running post-run listener: copy_logs_to_upload_dir 21:17:06 INFO - Copying logs to upload dir... 21:17:06 INFO - mkdir: /builds/slave/test/build/upload/logs 21:17:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.910951 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-13 21:17:06.329153) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 21:17:06.333089) ========= 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=fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999 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/adcea60a70320bb6460795eca6216dec7b7d17c62dd38068b5c668bb93d2c718aa20e998edfa3facd57e4f677edefc9f78ff55cd92687257f1cd8b848a123eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46537859c29fcca56d8f10bf6f49d0743c24699a7422b0f1f3597435ffdfef9ab5bbb9902e27b53bbdec39d7f9805a455fa87848390d6af52c75c4dd241e7d40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d4fb4f6f5dfe8a675ed557d967694593af7f9af8b192e3f761ce2fafcc328490e7b99783a4df7d2589b260b859c16d37206fbc09c9cf67a073371986029d05"} build_url:https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/R67rPubpTzecr7S6UKp9Eg/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/adcea60a70320bb6460795eca6216dec7b7d17c62dd38068b5c668bb93d2c718aa20e998edfa3facd57e4f677edefc9f78ff55cd92687257f1cd8b848a123eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46537859c29fcca56d8f10bf6f49d0743c24699a7422b0f1f3597435ffdfef9ab5bbb9902e27b53bbdec39d7f9805a455fa87848390d6af52c75c4dd241e7d40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41d4fb4f6f5dfe8a675ed557d967694593af7f9af8b192e3f761ce2fafcc328490e7b99783a4df7d2589b260b859c16d37206fbc09c9cf67a073371986029d05"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 21:17:06.357917) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 21:17:06.358244) ========= 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=fa44defc139c4ba8574fe040000001db-1473824946.227042-552069999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 21:17:06.442477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 21:17:06.442814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 21:17:06.443095) ========= ========= Total master_lag: 0.15 =========