builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1475186137.24 results: success (0) buildid: 20160929120120 builduid: 4d9272caea7d4f39ba3eb7ddee49eaab revision: 6a7c1c8db5548d077c7fa36bce41af629ba52bd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.244583) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.245069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.245390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.323246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.323535) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 14:55:37-- 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.3M=0s 2016-09-29 14:55:37 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.467039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.467367) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015179 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.520134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:37.520877) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6a7c1c8db5548d077c7fa36bce41af629ba52bd8 --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-beta --rev 6a7c1c8db5548d077c7fa36bce41af629ba52bd8 --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=edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 14:55:37,664 truncating revision to first 12 chars 2016-09-29 14:55:37,664 Setting DEBUG logging. 2016-09-29 14:55:37,664 attempt 1/10 2016-09-29 14:55:37,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6a7c1c8db554?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 14:55:38,093 unpacking tar archive at: mozilla-beta-6a7c1c8db554/testing/mozharness/ program finished with exit code 0 elapsedTime=0.859987 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:38.402457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:38.402799) ========= script_repo_revision: 6a7c1c8db5548d077c7fa36bce41af629ba52bd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:38.403227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:38.403528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 14:55:38.417120) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-29 14:55:38.417414) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:55:38 INFO - MultiFileLogger online at 20160929 14:55:38 in /builds/slave/test 14:55:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:55:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:55:38 INFO - {'append_to_log': False, 14:55:38 INFO - 'base_work_dir': '/builds/slave/test', 14:55:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:55:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:55:38 INFO - 'branch': 'Mozilla-Beta', 14:55:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:55:38 INFO - 'config_files': ('talos/linux_config.py',), 14:55:38 INFO - 'default_actions': ('clobber', 14:55:38 INFO - 'read-buildbot-config', 14:55:38 INFO - 'download-and-extract', 14:55:38 INFO - 'populate-webroot', 14:55:38 INFO - 'create-virtualenv', 14:55:38 INFO - 'install', 14:55:38 INFO - 'run-tests'), 14:55:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:55:38 INFO - 'download_minidump_stackwalk': True, 14:55:38 INFO - 'download_symbols': 'ondemand', 14:55:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:55:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:55:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:55:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:55:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:55:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:55:38 INFO - 'installer_path': 'installer.exe', 14:55:38 INFO - 'log_level': 'info', 14:55:38 INFO - 'log_name': 'talos', 14:55:38 INFO - 'log_to_console': True, 14:55:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:55:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:55:38 INFO - 'opt_config_files': (), 14:55:38 INFO - 'pip_index': False, 14:55:38 INFO - 'sps_profile': False, 14:55:38 INFO - 'sps_profile_interval': 0, 14:55:38 INFO - 'suite': 'dromaeojs-e10s', 14:55:38 INFO - 'system_bits': '32', 14:55:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:55:38 INFO - 'title': 'talos-linux64-ix-033', 14:55:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:55:38 INFO - 'use_talos_json': True, 14:55:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:55:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:55:38 INFO - 'work_dir': 'build'} 14:55:38 INFO - [mozharness: 2016-09-29 21:55:38.652314Z] Running clobber step. 14:55:38 INFO - Running pre-action listener: _resource_record_pre_action 14:55:38 INFO - Running main action method: clobber 14:55:38 INFO - rmtree: /builds/slave/test/build 14:55:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:55:39 INFO - Running post-action listener: _resource_record_post_action 14:55:39 INFO - [mozharness: 2016-09-29 21:55:39.623350Z] Finished clobber step (success) 14:55:39 INFO - [mozharness: 2016-09-29 21:55:39.623450Z] Running read-buildbot-config step. 14:55:39 INFO - Running pre-action listener: _resource_record_pre_action 14:55:39 INFO - Running main action method: read_buildbot_config 14:55:39 INFO - Using buildbot properties: 14:55:39 INFO - { 14:55:39 INFO - "project": "", 14:55:39 INFO - "product": "firefox", 14:55:39 INFO - "script_repo_revision": "production", 14:55:39 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:55:39 INFO - "repository": "", 14:55:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 14:55:39 INFO - "buildid": "20160929120120", 14:55:39 INFO - "pgo_build": "True", 14:55:39 INFO - "basedir": "/builds/slave/test", 14:55:39 INFO - "buildnumber": 134, 14:55:39 INFO - "slavename": "talos-linux64-ix-033", 14:55:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:55:39 INFO - "platform": "ubuntu64_hw", 14:55:39 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:55:39 INFO - "branch": "mozilla-beta", 14:55:39 INFO - "repo_path": "releases/mozilla-beta", 14:55:39 INFO - "revision": "6a7c1c8db5548d077c7fa36bce41af629ba52bd8", 14:55:39 INFO - "stage_platform": "linux64-pgo", 14:55:39 INFO - "builduid": "4d9272caea7d4f39ba3eb7ddee49eaab", 14:55:39 INFO - "slavebuilddir": "test" 14:55:39 INFO - } 14:55:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 14:55:39 INFO - Running post-action listener: _resource_record_post_action 14:55:39 INFO - [mozharness: 2016-09-29 21:55:39.625897Z] Finished read-buildbot-config step (success) 14:55:39 INFO - [mozharness: 2016-09-29 21:55:39.625986Z] Running download-and-extract step. 14:55:39 INFO - Running pre-action listener: _resource_record_pre_action 14:55:39 INFO - Running main action method: download_and_extract 14:55:39 INFO - mkdir: /builds/slave/test/build/tests 14:55: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')]} 14:55:39 INFO - https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:55:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:55:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:55:39 INFO - retry: Failed, sleeping 30 seconds before retrying 14:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 14:56:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:56:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:56:09 INFO - retry: Failed, sleeping 60 seconds before retrying 14:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 14:57:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:57:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:57:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 14:57:09 INFO - Caught exception: HTTP Error 404: Not Found 14:57:09 INFO - Caught exception: HTTP Error 404: Not Found 14:57:09 INFO - Caught exception: HTTP Error 404: Not Found 14:57:09 INFO - trying https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:57:09 INFO - Downloading https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:57:10 INFO - Downloaded 1327 bytes. 14:57:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:57:10 INFO - Using the following test package requirements: 14:57:10 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 14:57:10 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:57:10 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 14:57:10 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'jsshell-linux-x86_64.zip'], 14:57:10 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:57:10 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 14:57:10 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 14:57:10 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 14:57:10 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:57:10 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:57:10 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:57:10 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:10 INFO - https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:57:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:57:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:57:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:57:10 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:57:10 INFO - retry: Failed, sleeping 30 seconds before retrying 14:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:57:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:57:40 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:57:40 INFO - retry: Failed, sleeping 60 seconds before retrying 14:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:58:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:58:40 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:58:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 14:58:40 INFO - Caught exception: HTTP Error 404: Not Found 14:58:40 INFO - Caught exception: HTTP Error 404: Not Found 14:58:40 INFO - Caught exception: HTTP Error 404: Not Found 14:58:40 INFO - trying https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:58:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:58:41 INFO - Downloaded 21773222 bytes. 14:58:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:58:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:58:42 INFO - Return code: 0 14:58:42 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:42 INFO - https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:58:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:58:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:58:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:58:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:58:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:58:42 INFO - retry: Failed, sleeping 30 seconds before retrying 14:59:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:59:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:59:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:59:12 INFO - retry: Failed, sleeping 60 seconds before retrying 15:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 15:00:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:00:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:00:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 15:00:12 INFO - Caught exception: HTTP Error 404: Not Found 15:00:12 INFO - Caught exception: HTTP Error 404: Not Found 15:00:12 INFO - Caught exception: HTTP Error 404: Not Found 15:00:12 INFO - trying https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:00:12 INFO - Downloading https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:00:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:13 INFO - Downloaded 21773222 bytes. 15:00:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:00:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:00:15 INFO - Return code: 0 15:00: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')]} 15:00:15 INFO - https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:00:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:00:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:00:15 INFO - retry: Failed, sleeping 30 seconds before retrying 15:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 15:00:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:00:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:00:45 INFO - retry: Failed, sleeping 60 seconds before retrying 15:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 15:01:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:01:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:01:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 15:01:45 INFO - Caught exception: HTTP Error 404: Not Found 15:01:45 INFO - Caught exception: HTTP Error 404: Not Found 15:01:45 INFO - Caught exception: HTTP Error 404: Not Found 15:01:45 INFO - trying https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:01:45 INFO - Downloading https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:01:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:01:45 INFO - Downloaded 14413740 bytes. 15:01:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:01:46 INFO - Return code: 0 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:46 INFO - https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:01:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:01:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:01:46 INFO - retry: Failed, sleeping 30 seconds before retrying 15:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 15:02:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:02:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:02:16 INFO - retry: Failed, sleeping 60 seconds before retrying 15:03:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 15:03:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:03:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:03:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 15:03:16 INFO - Caught exception: HTTP Error 404: Not Found 15:03:16 INFO - Caught exception: HTTP Error 404: Not Found 15:03:16 INFO - Caught exception: HTTP Error 404: Not Found 15:03:16 INFO - trying https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:03:16 INFO - Downloading https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:03:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:03:17 INFO - Downloaded 56783903 bytes. 15:03:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:03:17 INFO - mkdir: /builds/slave/test/properties 15:03:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:03:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:03:17 INFO - Contents: 15:03:17 INFO - build_url:https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:03:18 INFO - Running post-action listener: _resource_record_post_action 15:03:18 INFO - Running post-action listener: set_extra_try_arguments 15:03:18 INFO - [mozharness: 2016-09-29 22:03:18.378069Z] Finished download-and-extract step (success) 15:03:18 INFO - [mozharness: 2016-09-29 22:03:18.378305Z] Running populate-webroot step. 15:03:18 INFO - Running pre-action listener: _resource_record_pre_action 15:03:18 INFO - Running main action method: populate_webroot 15:03:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:03:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:03:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:03:18 INFO - '--tppagecycles', 15:03:18 INFO - '7'], 15:03:18 INFO - 'tests': ['tsvgm']}}, 15:03:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:03:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:03:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:03:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:03:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['damp', 'tps']}, 15:03:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'tests': ['damp', 'tps']}, 15:03:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['dromaeo_dom']}, 15:03:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:03:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['basic_compositor_video']}, 15:03:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:03:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['a11yr', 15:03:18 INFO - 'ts_paint', 15:03:18 INFO - 'tpaint', 15:03:18 INFO - 'sessionrestore', 15:03:18 INFO - 'sessionrestore_no_auto_restore', 15:03:18 INFO - 'tabpaint']}, 15:03:18 INFO - 'other-e10s': {'tests': ['a11yr', 15:03:18 INFO - 'ts_paint', 15:03:18 INFO - 'tpaint', 15:03:18 INFO - 'sessionrestore', 15:03:18 INFO - 'sessionrestore_no_auto_restore', 15:03:18 INFO - 'tabpaint']}, 15:03:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:03:18 INFO - 'ts_paint', 15:03:18 INFO - 'tpaint', 15:03:18 INFO - 'sessionrestore', 15:03:18 INFO - 'sessionrestore_no_auto_restore', 15:03:18 INFO - 'tabpaint']}, 15:03:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:03:18 INFO - 'ts_paint', 15:03:18 INFO - 'tpaint', 15:03:18 INFO - 'sessionrestore', 15:03:18 INFO - 'sessionrestore_no_auto_restore', 15:03:18 INFO - 'tabpaint']}, 15:03:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['a11yr', 15:03:18 INFO - 'ts_paint', 15:03:18 INFO - 'tpaint', 15:03:18 INFO - 'sessionrestore', 15:03:18 INFO - 'sessionrestore_no_auto_restore', 15:03:18 INFO - 'tabpaint']}, 15:03:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['a11yr', 15:03:18 INFO - 'ts_paint', 15:03:18 INFO - 'tpaint', 15:03:18 INFO - 'sessionrestore', 15:03:18 INFO - 'sessionrestore_no_auto_restore', 15:03:18 INFO - 'tabpaint']}, 15:03:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['tsvgx', 15:03:18 INFO - 'tsvgr_opacity', 15:03:18 INFO - 'tart', 15:03:18 INFO - 'tscrollx', 15:03:18 INFO - 'cart']}, 15:03:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:03:18 INFO - 'tsvgr_opacity', 15:03:18 INFO - 'tart', 15:03:18 INFO - 'tscrollx', 15:03:18 INFO - 'cart']}, 15:03:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'talos_options': ['--disable-e10s'], 15:03:18 INFO - 'tests': ['tp5o']}, 15:03:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'tests': ['tp5o']}, 15:03:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'talos_options': ['--disable-e10s', 15:03:18 INFO - '--xperf_path', 15:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:18 INFO - 'tests': ['tp5n']}, 15:03:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:03:18 INFO - 'talos_options': ['--xperf_path', 15:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:18 INFO - 'tests': ['tp5n']}}, 15:03:18 INFO - 'talos.zip': {'path': '', 15:03:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:03:18 INFO - Running post-action listener: _resource_record_post_action 15:03:18 INFO - [mozharness: 2016-09-29 22:03:18.393824Z] Finished populate-webroot step (success) 15:03:18 INFO - [mozharness: 2016-09-29 22:03:18.393914Z] Running create-virtualenv step. 15:03:18 INFO - Running pre-action listener: _resource_record_pre_action 15:03:18 INFO - Running main action method: create_virtualenv 15:03:18 INFO - Creating virtualenv /builds/slave/test/build/venv 15:03:18 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 15:03:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:03:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:03:18 INFO - Using real prefix '/usr' 15:03:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:03:18 INFO - Installing distribute.............................................................................................................................................................................................done. 15:03:20 INFO - Installing pip.................done. 15:03:20 INFO - Return code: 0 15:03:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:03:20 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')]} 15:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:20 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')]} 15:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:20 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:20 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 15:03:20 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 15:03:20 INFO - Using env: {'DISPLAY': ':0', 15:03:20 INFO - 'HOME': '/home/cltbld', 15:03:20 INFO - 'LANG': 'en_US.UTF-8', 15:03:20 INFO - 'LANGUAGE': 'en_US:en', 15:03:20 INFO - 'LOGNAME': 'cltbld', 15:03:20 INFO - 'MAIL': '/var/mail/cltbld', 15:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:20 INFO - 'MOZ_NO_REMOTE': '1', 15:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:20 INFO - 'NO_EM_RESTART': '1', 15:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:20 INFO - 'PWD': '/builds/slave/test', 15:03:20 INFO - 'SHELL': '/bin/bash', 15:03:20 INFO - 'SHLVL': '1', 15:03:20 INFO - 'TERM': 'linux', 15:03:20 INFO - 'TMOUT': '86400', 15:03:20 INFO - 'USER': 'cltbld', 15:03:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:20 INFO - '_': '/tools/buildbot/bin/python'} 15:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:21 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 15:03:21 INFO - Cleaning up... 15:03:21 INFO - Return code: 0 15:03:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:03:21 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')]} 15:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:21 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')]} 15:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:21 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:21 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 15:03:21 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 15:03:21 INFO - Using env: {'DISPLAY': ':0', 15:03:21 INFO - 'HOME': '/home/cltbld', 15:03:21 INFO - 'LANG': 'en_US.UTF-8', 15:03:21 INFO - 'LANGUAGE': 'en_US:en', 15:03:21 INFO - 'LOGNAME': 'cltbld', 15:03:21 INFO - 'MAIL': '/var/mail/cltbld', 15:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:21 INFO - 'MOZ_NO_REMOTE': '1', 15:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:21 INFO - 'NO_EM_RESTART': '1', 15:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:21 INFO - 'PWD': '/builds/slave/test', 15:03:21 INFO - 'SHELL': '/bin/bash', 15:03:21 INFO - 'SHLVL': '1', 15:03:21 INFO - 'TERM': 'linux', 15:03:21 INFO - 'TMOUT': '86400', 15:03:21 INFO - 'USER': 'cltbld', 15:03:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:21 INFO - '_': '/tools/buildbot/bin/python'} 15:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:21 INFO - Downloading/unpacking psutil>=3.1.1 15:03:21 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 15:03:21 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 15:03:21 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 15:03:21 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 15:03:21 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 15:03:21 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 15:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:23 INFO - Installing collected packages: psutil 15:03:23 INFO - Running setup.py install for psutil 15:03:23 INFO - building 'psutil._psutil_linux' extension 15:03:23 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 15:03:23 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 15:03:23 INFO - building 'psutil._psutil_posix' extension 15:03:23 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 15:03:23 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 15:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:03:23 INFO - Successfully installed psutil 15:03:23 INFO - Cleaning up... 15:03:23 INFO - Return code: 0 15:03:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:23 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:23 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 15:03:23 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 15:03:23 INFO - Using env: {'DISPLAY': ':0', 15:03:23 INFO - 'HOME': '/home/cltbld', 15:03:23 INFO - 'LANG': 'en_US.UTF-8', 15:03:23 INFO - 'LANGUAGE': 'en_US:en', 15:03:23 INFO - 'LOGNAME': 'cltbld', 15:03:23 INFO - 'MAIL': '/var/mail/cltbld', 15:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:23 INFO - 'MOZ_NO_REMOTE': '1', 15:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:23 INFO - 'NO_EM_RESTART': '1', 15:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:23 INFO - 'PWD': '/builds/slave/test', 15:03:23 INFO - 'SHELL': '/bin/bash', 15:03:23 INFO - 'SHLVL': '1', 15:03:23 INFO - 'TERM': 'linux', 15:03:23 INFO - 'TMOUT': '86400', 15:03:23 INFO - 'USER': 'cltbld', 15:03:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:23 INFO - '_': '/tools/buildbot/bin/python'} 15:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:03:24 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 15:03:24 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 15:03:24 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 15:03:24 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 15:03:24 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 15:03:24 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 15:03:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:03:26 INFO - Installing collected packages: mozsystemmonitor 15:03:26 INFO - Running setup.py install for mozsystemmonitor 15:03:26 INFO - Successfully installed mozsystemmonitor 15:03:26 INFO - Cleaning up... 15:03:26 INFO - Return code: 0 15:03:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:03:26 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')]} 15:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:26 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')]} 15:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:26 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:26 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 15:03:26 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 15:03:26 INFO - Using env: {'DISPLAY': ':0', 15:03:26 INFO - 'HOME': '/home/cltbld', 15:03:26 INFO - 'LANG': 'en_US.UTF-8', 15:03:26 INFO - 'LANGUAGE': 'en_US:en', 15:03:26 INFO - 'LOGNAME': 'cltbld', 15:03:26 INFO - 'MAIL': '/var/mail/cltbld', 15:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:26 INFO - 'MOZ_NO_REMOTE': '1', 15:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:26 INFO - 'NO_EM_RESTART': '1', 15:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:26 INFO - 'PWD': '/builds/slave/test', 15:03:26 INFO - 'SHELL': '/bin/bash', 15:03:26 INFO - 'SHLVL': '1', 15:03:26 INFO - 'TERM': 'linux', 15:03:26 INFO - 'TMOUT': '86400', 15:03:26 INFO - 'USER': 'cltbld', 15:03:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:26 INFO - '_': '/tools/buildbot/bin/python'} 15:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:26 INFO - Downloading/unpacking jsonschema==2.5.1 15:03:26 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 15:03:26 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 15:03:26 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 15:03:26 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 15:03:26 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 15:03:26 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 15:03:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:03:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:03:28 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 15:03:28 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 15:03:28 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 15:03:28 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 15:03:28 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 15:03:28 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 15:03:28 INFO - Downloading functools32-3.2.3-2.tar.gz 15:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:03:28 INFO - warning: no files found matching '*.txt' 15:03:28 INFO - no previously-included directories found matching 'build' 15:03:28 INFO - no previously-included directories found matching 'dist' 15:03:28 INFO - no previously-included directories found matching '.git*' 15:03:28 INFO - Installing collected packages: jsonschema, functools32 15:03:28 INFO - Running setup.py install for functools32 15:03:28 INFO - warning: no files found matching '*.txt' 15:03:28 INFO - no previously-included directories found matching 'build' 15:03:28 INFO - no previously-included directories found matching 'dist' 15:03:28 INFO - no previously-included directories found matching '.git*' 15:03:28 INFO - Successfully installed jsonschema functools32 15:03:28 INFO - Cleaning up... 15:03:28 INFO - Return code: 0 15:03:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:03:28 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')]} 15:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:28 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')]} 15:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:28 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:28 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 15:03:28 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 15:03:28 INFO - Using env: {'DISPLAY': ':0', 15:03:28 INFO - 'HOME': '/home/cltbld', 15:03:28 INFO - 'LANG': 'en_US.UTF-8', 15:03:28 INFO - 'LANGUAGE': 'en_US:en', 15:03:28 INFO - 'LOGNAME': 'cltbld', 15:03:28 INFO - 'MAIL': '/var/mail/cltbld', 15:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:28 INFO - 'MOZ_NO_REMOTE': '1', 15:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:28 INFO - 'NO_EM_RESTART': '1', 15:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:28 INFO - 'PWD': '/builds/slave/test', 15:03:28 INFO - 'SHELL': '/bin/bash', 15:03:28 INFO - 'SHLVL': '1', 15:03:28 INFO - 'TERM': 'linux', 15:03:28 INFO - 'TMOUT': '86400', 15:03:28 INFO - 'USER': 'cltbld', 15:03:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:28 INFO - '_': '/tools/buildbot/bin/python'} 15:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:03:29 INFO - Cleaning up... 15:03:29 INFO - Return code: 0 15:03:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:03:29 INFO - Using env: {'DISPLAY': ':0', 15:03:29 INFO - 'HOME': '/home/cltbld', 15:03:29 INFO - 'LANG': 'en_US.UTF-8', 15:03:29 INFO - 'LANGUAGE': 'en_US:en', 15:03:29 INFO - 'LOGNAME': 'cltbld', 15:03:29 INFO - 'MAIL': '/var/mail/cltbld', 15:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:29 INFO - 'MOZ_NO_REMOTE': '1', 15:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:29 INFO - 'NO_EM_RESTART': '1', 15:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:29 INFO - 'PWD': '/builds/slave/test', 15:03:29 INFO - 'SHELL': '/bin/bash', 15:03:29 INFO - 'SHLVL': '1', 15:03:29 INFO - 'TERM': 'linux', 15:03:29 INFO - 'TMOUT': '86400', 15:03:29 INFO - 'USER': 'cltbld', 15:03:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:29 INFO - '_': '/tools/buildbot/bin/python'} 15:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:29 INFO - Downloading/unpacking blobuploader==1.2.4 15:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:31 INFO - Downloading blobuploader-1.2.4.tar.gz 15:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:03:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:03:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 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 15:03:31 INFO - Downloading docopt-0.6.1.tar.gz 15:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:03:31 INFO - Installing collected packages: blobuploader, requests, docopt 15:03:31 INFO - Running setup.py install for blobuploader 15:03:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:03:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:03:32 INFO - Running setup.py install for requests 15:03:32 INFO - Running setup.py install for docopt 15:03:32 INFO - Successfully installed blobuploader requests docopt 15:03:32 INFO - Cleaning up... 15:03:32 INFO - Return code: 0 15:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:32 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:32 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 15:03:32 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 15:03:32 INFO - Using env: {'DISPLAY': ':0', 15:03:32 INFO - 'HOME': '/home/cltbld', 15:03:32 INFO - 'LANG': 'en_US.UTF-8', 15:03:32 INFO - 'LANGUAGE': 'en_US:en', 15:03:32 INFO - 'LOGNAME': 'cltbld', 15:03:32 INFO - 'MAIL': '/var/mail/cltbld', 15:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:32 INFO - 'MOZ_NO_REMOTE': '1', 15:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:32 INFO - 'NO_EM_RESTART': '1', 15:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:32 INFO - 'PWD': '/builds/slave/test', 15:03:32 INFO - 'SHELL': '/bin/bash', 15:03:32 INFO - 'SHLVL': '1', 15:03:32 INFO - 'TERM': 'linux', 15:03:32 INFO - 'TMOUT': '86400', 15:03:32 INFO - 'USER': 'cltbld', 15:03:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:32 INFO - '_': '/tools/buildbot/bin/python'} 15:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:32 INFO - Running setup.py (path:/tmp/pip-IgpL0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:32 INFO - Running setup.py (path:/tmp/pip-As2n8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:32 INFO - Running setup.py (path:/tmp/pip-oCHlaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:32 INFO - Running setup.py (path:/tmp/pip-cxDYGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:33 INFO - Running setup.py (path:/tmp/pip-ZFJurU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:33 INFO - Running setup.py (path:/tmp/pip-h8th3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:33 INFO - Running setup.py (path:/tmp/pip-m1SU_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:33 INFO - Running setup.py (path:/tmp/pip-_TNyQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:33 INFO - Running setup.py (path:/tmp/pip-GcrCQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:33 INFO - Running setup.py (path:/tmp/pip-IICyBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:33 INFO - Running setup.py (path:/tmp/pip-kBQgZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:33 INFO - Running setup.py (path:/tmp/pip-cSSQCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:33 INFO - Running setup.py (path:/tmp/pip-H_UC62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:33 INFO - Running setup.py (path:/tmp/pip-pBb_Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:33 INFO - Running setup.py (path:/tmp/pip-YHKVRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:33 INFO - Running setup.py (path:/tmp/pip-ZfB7uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:33 INFO - Running setup.py (path:/tmp/pip-hsvppS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:03:33 INFO - Running setup.py install for manifestparser 15:03:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Running setup.py install for mozcrash 15:03:34 INFO - Running setup.py install for mozdebug 15:03:34 INFO - Running setup.py install for mozdevice 15:03:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Running setup.py install for mozfile 15:03:34 INFO - Running setup.py install for mozhttpd 15:03:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Running setup.py install for mozinfo 15:03:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Running setup.py install for mozInstall 15:03:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Running setup.py install for mozleak 15:03:34 INFO - Running setup.py install for mozlog 15:03:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:03:34 INFO - Running setup.py install for moznetwork 15:03:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Running setup.py install for mozprocess 15:03:35 INFO - Running setup.py install for mozprofile 15:03:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Running setup.py install for mozrunner 15:03:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Running setup.py install for mozscreenshot 15:03:35 INFO - Running setup.py install for moztest 15:03:35 INFO - Running setup.py install for mozversion 15:03:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:03:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:03:35 INFO - Cleaning up... 15:03:35 INFO - Return code: 0 15:03:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03:35 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')]} 15:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:35 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')]} 15:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:35 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:35 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 15:03:35 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 15:03:35 INFO - Using env: {'DISPLAY': ':0', 15:03:35 INFO - 'HOME': '/home/cltbld', 15:03:35 INFO - 'LANG': 'en_US.UTF-8', 15:03:35 INFO - 'LANGUAGE': 'en_US:en', 15:03:35 INFO - 'LOGNAME': 'cltbld', 15:03:35 INFO - 'MAIL': '/var/mail/cltbld', 15:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:35 INFO - 'MOZ_NO_REMOTE': '1', 15:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:35 INFO - 'NO_EM_RESTART': '1', 15:03:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:35 INFO - 'PWD': '/builds/slave/test', 15:03:35 INFO - 'SHELL': '/bin/bash', 15:03:35 INFO - 'SHLVL': '1', 15:03:35 INFO - 'TERM': 'linux', 15:03:35 INFO - 'TMOUT': '86400', 15:03:35 INFO - 'USER': 'cltbld', 15:03:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:35 INFO - '_': '/tools/buildbot/bin/python'} 15:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:03:35 INFO - Running setup.py (path:/tmp/pip-wLePl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:03:36 INFO - Running setup.py (path:/tmp/pip-zbDV_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:03:36 INFO - Running setup.py (path:/tmp/pip-3O914F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:36 INFO - Running setup.py (path:/tmp/pip-WdL30q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:36 INFO - Running setup.py (path:/tmp/pip-nqZ73Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:36 INFO - Running setup.py (path:/tmp/pip-2t4_dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:36 INFO - Running setup.py (path:/tmp/pip-OT8XMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:36 INFO - Running setup.py (path:/tmp/pip-AdUnnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:36 INFO - Running setup.py (path:/tmp/pip-2GWXQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:36 INFO - Running setup.py (path:/tmp/pip-xqV0P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:36 INFO - Running setup.py (path:/tmp/pip-sSBx2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:36 INFO - Running setup.py (path:/tmp/pip-ejPfwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:36 INFO - Running setup.py (path:/tmp/pip-HQs49X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:36 INFO - Running setup.py (path:/tmp/pip-cxCtAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:36 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)) 15:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:36 INFO - Running setup.py (path:/tmp/pip-s1O17S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:37 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)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:37 INFO - Running setup.py (path:/tmp/pip-ptXWg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:37 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)) 15:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:37 INFO - Running setup.py (path:/tmp/pip-xscsEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 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)) 15:03:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:39 INFO - Downloading blessings-1.6.tar.gz 15:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:39 INFO - Installing collected packages: blessings 15:03:39 INFO - Running setup.py install for blessings 15:03:39 INFO - Successfully installed blessings 15:03:39 INFO - Cleaning up... 15:03:39 INFO - Return code: 0 15:03:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:39 INFO - Reading from file tmpfile_stdout 15:03:39 INFO - Current package versions: 15:03:39 INFO - argparse == 1.2.1 15:03:39 INFO - blessings == 1.6 15:03:39 INFO - blobuploader == 1.2.4 15:03:39 INFO - docopt == 0.6.1 15:03:39 INFO - functools32 == 3.2.3-2 15:03:39 INFO - jsonschema == 2.5.1 15:03:39 INFO - manifestparser == 1.1 15:03:39 INFO - mozInstall == 1.12 15:03:39 INFO - mozcrash == 0.17 15:03:39 INFO - mozdebug == 0.1 15:03:39 INFO - mozdevice == 0.48 15:03:39 INFO - mozfile == 1.2 15:03:39 INFO - mozhttpd == 0.7 15:03:39 INFO - mozinfo == 0.9 15:03:39 INFO - mozleak == 0.1 15:03:39 INFO - mozlog == 3.3 15:03:39 INFO - moznetwork == 0.27 15:03:39 INFO - mozprocess == 0.23 15:03:39 INFO - mozprofile == 0.28 15:03:39 INFO - mozrunner == 6.12 15:03:39 INFO - mozscreenshot == 0.1 15:03:39 INFO - mozsystemmonitor == 0.3 15:03:39 INFO - moztest == 0.7 15:03:39 INFO - mozversion == 1.4 15:03:39 INFO - psutil == 3.1.1 15:03:39 INFO - requests == 1.2.3 15:03:39 INFO - wsgiref == 0.1.2 15:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:39 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 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:39 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 15:03:39 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 15:03:39 INFO - Using env: {'DISPLAY': ':0', 15:03:39 INFO - 'HOME': '/home/cltbld', 15:03:39 INFO - 'LANG': 'en_US.UTF-8', 15:03:39 INFO - 'LANGUAGE': 'en_US:en', 15:03:39 INFO - 'LOGNAME': 'cltbld', 15:03:39 INFO - 'MAIL': '/var/mail/cltbld', 15:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:39 INFO - 'MOZ_NO_REMOTE': '1', 15:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:39 INFO - 'NO_EM_RESTART': '1', 15:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:39 INFO - 'PWD': '/builds/slave/test', 15:03:39 INFO - 'SHELL': '/bin/bash', 15:03:39 INFO - 'SHLVL': '1', 15:03:39 INFO - 'TERM': 'linux', 15:03:39 INFO - 'TMOUT': '86400', 15:03:39 INFO - 'USER': 'cltbld', 15:03:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:39 INFO - '_': '/tools/buildbot/bin/python'} 15:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 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)) 15:03:39 INFO - Cleaning up... 15:03:39 INFO - Return code: 0 15:03:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:03: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')]} 15:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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')]} 15:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', '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 15:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:03:39 INFO - Using env: {'DISPLAY': ':0', 15:03:39 INFO - 'HOME': '/home/cltbld', 15:03:39 INFO - 'LANG': 'en_US.UTF-8', 15:03:39 INFO - 'LANGUAGE': 'en_US:en', 15:03:39 INFO - 'LOGNAME': 'cltbld', 15:03:39 INFO - 'MAIL': '/var/mail/cltbld', 15:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:39 INFO - 'MOZ_NO_REMOTE': '1', 15:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:39 INFO - 'NO_EM_RESTART': '1', 15:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:39 INFO - 'PWD': '/builds/slave/test', 15:03:39 INFO - 'SHELL': '/bin/bash', 15:03:39 INFO - 'SHLVL': '1', 15:03:39 INFO - 'TERM': 'linux', 15:03:39 INFO - 'TMOUT': '86400', 15:03:39 INFO - 'USER': 'cltbld', 15:03:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:39 INFO - '_': '/tools/buildbot/bin/python'} 15:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:03:39 INFO - Cleaning up... 15:03:40 INFO - Return code: 0 15:03:40 INFO - Running post-action listener: _resource_record_post_action 15:03:40 INFO - Running post-action listener: _start_resource_monitoring 15:03:40 INFO - Starting resource monitoring. 15:03:40 INFO - [mozharness: 2016-09-29 22:03:40.036923Z] Finished create-virtualenv step (success) 15:03:40 INFO - [mozharness: 2016-09-29 22:03:40.037397Z] Running install step. 15:03:40 INFO - Running pre-action listener: _resource_record_pre_action 15:03:40 INFO - Running main action method: install 15:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:40 INFO - Reading from file tmpfile_stdout 15:03:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:40 INFO - Reading from file tmpfile_stdout 15:03:40 INFO - Output received: 15:03:40 INFO - Usage: mozinstall [options] installer 15:03:40 INFO - Options: 15:03:40 INFO - -h, --help show this help message and exit 15:03:40 INFO - -d DEST, --destination=DEST 15:03:40 INFO - Directory to install application into. [default: 15:03:40 INFO - "/builds/slave/test"] 15:03:40 INFO - --app=APP Application being installed. [default: firefox] 15:03:40 INFO - mkdir: /builds/slave/test/build/application 15:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:03:54 INFO - Reading from file tmpfile_stdout 15:03:54 INFO - Output received: 15:03:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:54 INFO - Running post-action listener: _resource_record_post_action 15:03:54 INFO - [mozharness: 2016-09-29 22:03:54.992906Z] Finished install step (success) 15:03:54 INFO - [mozharness: 2016-09-29 22:03:54.993184Z] Running run-tests step. 15:03:54 INFO - Running pre-action listener: _resource_record_pre_action 15:03:54 INFO - Running main action method: run_tests 15:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:54 INFO - Python 2.7.3 15:03:54 INFO - Return code: 0 15:03:54 INFO - grabbing minidump binary from tooltool 15:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:03:55 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 0x1f8a570>, '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 0x1f8b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:55 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 15:03:55 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 15:03:55 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 15:03:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:55 INFO - Return code: 0 15:03:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 15:03:55 INFO - Using env: {'DISPLAY': ':0', 15:03:55 INFO - 'HOME': '/home/cltbld', 15:03:55 INFO - 'LANG': 'en_US.UTF-8', 15:03:55 INFO - 'LANGUAGE': 'en_US:en', 15:03:55 INFO - 'LOGNAME': 'cltbld', 15:03:55 INFO - 'MAIL': '/var/mail/cltbld', 15:03:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:55 INFO - 'MOZ_NO_REMOTE': '1', 15:03:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:55 INFO - 'NO_EM_RESTART': '1', 15:03:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:55 INFO - 'PWD': '/builds/slave/test', 15:03:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:55 INFO - 'SHELL': '/bin/bash', 15:03:55 INFO - 'SHLVL': '1', 15:03:55 INFO - 'TERM': 'linux', 15:03:55 INFO - 'TMOUT': '86400', 15:03:55 INFO - 'USER': 'cltbld', 15:03:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367', 15:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:55 INFO - '_': '/tools/buildbot/bin/python'} 15:03:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 15:03:55 INFO - mozversion application_buildid: 20160929120120 15:03:55 INFO - mozversion application_changeset: 6a7c1c8db5548d077c7fa36bce41af629ba52bd8 15:03:55 INFO - mozversion application_display_name: Firefox 15:03:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:55 INFO - mozversion application_name: Firefox 15:03:55 INFO - mozversion application_remotingname: firefox 15:03:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:03:55 INFO - mozversion application_vendor: Mozilla 15:03:55 INFO - mozversion application_version: 50.0 15:03:55 INFO - mozversion platform_buildid: 20160929120120 15:03:55 INFO - mozversion platform_changeset: 6a7c1c8db5548d077c7fa36bce41af629ba52bd8 15:03:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:03:55 INFO - mozversion platform_version: 50.0 15:03:55 INFO - using testdate: 1475186635 15:03:55 INFO - actual date: 1475186635 15:03:55 INFO - starting webserver on 'localhost:42047' 15:03:55 INFO - SUITE-START | Running 2 tests 15:03:55 INFO - TEST-START | dromaeo_css 15:03:55 INFO - operating with platform_type : linux_ 15:03:55 INFO - Initialising browser for dromaeo_css test... 15:03:55 INFO - TEST-INFO | started process 21676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6JdprJ/profile http://localhost:42047/getInfo.html) 15:04:00 INFO - PROCESS | 21676 | __metrics Screen width/height:1600/1200 15:04:00 INFO - PROCESS | 21676 | colorDepth:24 15:04:00 INFO - PROCESS | 21676 | Browser inner width/height: 1024/697 15:04:00 INFO - PROCESS | 21676 | __metrics 15:04:01 ERROR - PROCESS | 21676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:04:01 INFO - TEST-INFO | 21676: exit 0 15:04:01 INFO - Browser initialized. 15:04:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:04:01 INFO - TEST-INFO | started process 21801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6JdprJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:13 INFO - PROCESS | 21801 | RSS: Main: 149782528 15:04:13 INFO - PROCESS | 21801 | 15:05:03 INFO - PROCESS | 21801 | 1475186703209 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] 15:07:11 INFO - PROCESS | 21801 | Cycle 1(1): loaded http://localhost:42047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42047/tests/dromaeo/cssquery-ext.html) 15:07:12 INFO - PROCESS | 21801 | RSS: Main: 158851072 15:07:12 INFO - PROCESS | 21801 | 15:10:14 INFO - PROCESS | 21801 | Cycle 1(1): loaded http://localhost:42047/tests/dromaeo/cssquery-ext.html (next: http://localhost:42047/tests/dromaeo/cssquery-jquery.html) 15:10:15 INFO - PROCESS | 21801 | RSS: Main: 155770880 15:10:15 INFO - PROCESS | 21801 | 15:13:16 INFO - PROCESS | 21801 | Cycle 1(1): loaded http://localhost:42047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42047/tests/dromaeo/cssquery-mootools.html) 15:13:17 INFO - PROCESS | 21801 | RSS: Main: 155000832 15:13:17 INFO - PROCESS | 21801 | 15:16:19 INFO - PROCESS | 21801 | Cycle 1(1): loaded http://localhost:42047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42047/tests/dromaeo/cssquery-prototype.html) 15:16:19 INFO - PROCESS | 21801 | RSS: Main: 156635136 15:16:19 INFO - PROCESS | 21801 | 15:19:22 INFO - PROCESS | 21801 | Cycle 1(1): loaded http://localhost:42047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42047/tests/dromaeo/cssquery-yui.html) 15:19:22 INFO - PROCESS | 21801 | RSS: Main: 157544448 15:19:22 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | Cycle 1(1): loaded http://localhost:42047/tests/dromaeo/cssquery-yui.html (next: http://localhost:42047/tests/dromaeo/cssquery-dojo.html) 15:22:25 INFO - PROCESS | 21801 | RSS: Main: 156758016 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | __start_tp_report 15:22:25 INFO - PROCESS | 21801 | _x_x_mozilla_page_load 15:22:25 INFO - PROCESS | 21801 | _x_x_mozilla_page_load_details 15:22:25 INFO - PROCESS | 21801 | |i|pagename|runs| 15:22:25 INFO - PROCESS | 21801 | |0;dojo.html;3257.674232576742;3269.051974927271;3279.147421670365;3286.3098749262654;3306.8677252909883;5717.2281741964825;5797.739101740426;5815.331236907757;5823;5841.766329346821;5655.5475561955045;5707.343655479621;5710.428957104287;5716.514096301809;5724.542036637069;5181.740912954356;5201.973990130063;5212.765425555859;5243.606729495303;5254.632175747699;5244.396894357141;5247.580193584504;5251.86870328241;5251.921221181686;5289.20661900716;5103.872403189913;5122.129238029525;5224.1902505111575;5231.476852314776;5240.109181439165;5104.464031276718;5213.947860521384;5226.3989641191365;5232.843014709565;5266.7629956652045;5131.846044618667;5167.638265321429;5168.741562921877;5184.196449550326;5186.766595503212;5524.14375771756;5545.417731138253;5617;5676.091825307973;5740.54075673945;5955.166276721219;6030.396960303979;6043.335233124353;6056.909146362808;6076.544259180535;6080.2399700037495;6080.908786368208;6081.969590152021;6092.45167934888;6106.084087386883;5532.031894418501;5604.495595396434;5642.012647786621;5650.180723795027;5664.858378540528;6170.568060235741;6209.6895155242055;6249.1563638908165;6251.562390632612;6254.312025677172;5865.88268234633;5868.735906884201;5873.177755114288;5876.676782776988;5898.8230353089475;5838.562107841929;5909.320428150818;5965.492933100735;5967.492763115184;6062.393760623991;6030.48740857032;6142.406692085091;6144.815655530341;6151.569390142647;6156.353582873734;6169.475594574512;6171.722272497748;6185.257769067651;6186.783462578788;6198.132261483396;4548.567886050886;4641.094986477605;4734.573888350065;4742.07529531738;4751.596114330251;4137.50349958007;4197.097624010852;4203.180379825966;4221.873343799691;4228.513720922072;5947.1079338099635;5957.434043765836;5961.314448838352;5966.161178077604;5987.790427335022;5940.6435613863305;6069.2110025696375;6238.656873871981;6240.157578726814;6245.094461303085;5906.468417842329;5936.821895343147;5944.494717948936;5959.046552551657;5978.103284507359;5299.205119232146;5316;5326.493983071602;5331.840044798662;5345.518903298722;6130.1724267224245;6145.9692701536205;6249.593776404519;6394.71223794921;6429.228492580826;6111.500579230309;6197.690115494117;6203.627782333075;6206.224221972254;6207.906881396692;6344.777932772331;6392.648404337806;6406.199225096863;6408.423241908251;6418.743250269937;5768.826935191951;5919.911201331897;6040.063790112539;6080.148779170831;6093.238345206849;6070.757169713339;6137.9286238596105;6145.8156255312415;6153.261608606996;6161.845953851011;6009.218801555945;6018.518518518596;6038.184845046038;6043.335233124265;6055.364186760326;5816.592838501433;5992.610480318765;5997.13041608973;6002.189704390026;6039.184710064085;6043.244594425697;6068.6358818471035;6073.726682299395;6084.421979911901;6110.114033465212;6041.395860414099;6044.576879618385;6065.636061836304;6118.235220597426;6131.386861314011;5581.413951535193;5722.484976352148;5968.7612495501435;5989.8203053908455;6000.159977603052 15:22:25 INFO - PROCESS | 21801 | |1;ext.html;589.764094362255;612.4732729852327;645.3772109913933;662.4038365471075;698.7868700046483;41564.79217603912;47298.52701472984;47347.76326118373;47511;47553.81115472115;47355.526444735544;48160.51839481604;48229;48249;48335.27497087546;9091.77270568236;9223.031581683927;9238.214751746109;9244.537773111317;9276.953615231914;9125.863112053325;9185.724428267129;9212.309076819232;9225.861612075823;9259.259259259277;9230.58462369195;9283.814323713521;9284.535773211346;9291.303152263574;9293.95353023234;9209.079092090771;9231.030741772118;9247.12152345526;9247.953760231223;9251.352405331629;9218.216451601622;9222.40054396462;9230.307726920508;9269.351145419823;9296.814063718688;44960.550394495964;45657;45692;45692.086158276645;45706.31440528395;4238.364245363189;4630.791614377327;4767.642426817968;4768.403949506312;4848.757562121879;36106.638933610855;36206.818965905266;36334.27331453356;36534.817325913464;37439.62560374389;4770.522947705236;4770.61835053195;4835.492273311287;4841.419029716457;4876.853694389174;369983;370645;371654;374995;375648;65602;65926.34073659201;65981;66015;66030;40153;41395.586044139774;41455.1708965819;67946.66026669835;68033.2786688527;18276.908615457105;18300.084995750425;18334;18446.98541580199;18494.907525462557;15039.172845493604;15137.091774493565;15194.696106077816;15227.086374817325;15227.847721522643;21291.68062479064;21384;21465.248716294856;21527.67708484374;21623.351299460726;7538.266198774312;7654.617269136521;7764.650590723431;7780.533168009937;7920.564368959647;1054.488573042074;1078.5362294213564;1079.287670137721;1088.9509972051276;1115.1469126118525;34350.31299374049;34363.31273374568;34364.31271374559;34618.65381346154;34753.13117172091;1174.723939874129;1190.1193117093462;1196.347990345264;1225.497546006151;1247.5758242197696;17944.41782462875;18165.54586135357;18234.635307293778;18269.106779744918;18427.447176584723;581126;590803;591069;591381;591737;66414.66792666005;66923.66538167278;67043;67137;67348;1458.9197594132213;1462.166565057928;1482.1773915477013;1495.2000679636342;1498.168516473346;33424.498632520044;33593;33761.493577595866;33882.32235355328;33910;57922.4207757917;58410;58535.707321463124;58617;58665.41334586599;486514;488835;489192;490546;491937;31382.68617313889;32024.6797532031;32296.192595185308;32525.674743252264;32544.186395340304;53238.2014269794;53427.732861337;53789.46210537844;54218.186727199914;54734.726326368116;44190.33714494349;44696.19667202518;46459.53540464687;47168.528314716415;48144.75927620479;45144.54855451403;45587.31619025651;46243.3063504041;46493.07013859636;48013;44790.3281450772;46301;46400.767996159804;46881.296780549004;47956.760216198694;38345.23309533738;38603.42094868523;39080.609193907694;39605.2078958425;39743.403848942864;30501.54247686242;30600.693993059784;30691.846540767154;30765;30965.845170774002 15:22:25 INFO - PROCESS | 21801 | |2;jquery.html;412.2682239025727;421.57210431412125;436.1538615086732;440.8743508100191;444.44444444444446;18991.71512427313;20675.586488270226;20958.89520552397;21180.89409552952;21380.57238855222;20683.521534925538;21064.8946755266;21074.367768966917;21651.566968660656;21712.457188570253;5802.274715660532;6003.429674180968;6008.8497787555225;6011.158437818709;6016.8495787605225;5943.88112237755;5961.85095372617;5992.880142397149;6007.098935159717;6009.09863520471;5743.3108027036815;5917.792877249297;5919.585629005971;5954.880902381949;5955.821325360246;5869.325027621814;5871.266091738533;5910.261217347832;5923.881522369528;5929.229200203989;5164.767585458663;5262.158054711266;5311.840644780663;5317.867053323659;5324.148136298212;25091;25314;25404;25422;25546.87226563874;2711.5797051457057;2797.5384061629807;2835.135283738459;3020.5318175682582;3136.3570468053995;16005.439809606607;16194.676106477922;16206.432774852823;16294.755578666329;16650.83349166505;2031.6444622191057;2086.968695469569;2110.778368271325;2111.0183764549406;2185.8961224581644;80911;81562;82100;83042;84370.57814710887;11611.825822612667;11622.6513204604;11794.764104717857;12072;12155.939220304019;16548.503544893672;16584.75122873158;16594.336226551044;16609.169541522875;16654;8749.737507874774;9166.587503562356;9218.124278193562;9365.250779937589;9405.012473690163;8773.122687731176;8880.777980550538;8912.197902188704;9079.500627465553;9173.770655733526;6991.196012458632;7268.454865884974;7279.745208917662;7312.707491700379;7314.342828585707;2084.395525297677;2088.3734879536078;2112.4930016796166;2177.107385971744;2191.6959409151527;1026.5414332673354;1036.8030074286012;1039.4542864995938;1069.4759567811716;1134.9205555611193;20595.691064634044;20979.895100524398;20995.79004209969;21047.78952210489;21598.676019859715;1067.1676092647747;1091.0562363555468;1108.6175269531998;1110.9055730262858;1171.37916904041;11625.76748465026;12081.45633446497;12132.757344853053;12278.631641050782;12305.323207223688;538602;542101;542138;543563;552873;78070.6096469514;81992.59003705063;82347.17652823395;82877.58561207155;83089.16910830814;1072.922893006572;1078.6332646900091;1079.2283517285023;1089.3572792052569;1089.3844977587796;18042.819571804113;19114.904425477784;19207.231710731416;19209.231630734615;19537.63236573483;45110.32334514919;45285;45903.3114503276;46167.538324616326;47611;60102;62496.68751656394;63798.362016379244;64370.35629643644;65482.67258663676;9014.549272536216;9334.533273336441;9547.856782148134;9686.903130968882;9720.75698107553;12623.36883155857;13299.401526931118;13777.966652501304;14327.78508322355;14414.495492657707;10855.674329769803;12317.876821231674;12539.811902821648;12547.811782823082;12776.808347874603;11292.49183786748;11750.882491174978;11834.644960651194;12033.45849436795;12233;11926.880731192578;12036.338001410006;12464.252144871336;12503.187292825936;12619.81070283928;9309.627614895599;9378.718638440858;9433.339666223574;9591.952040239754;9701.514924253901;11122.944385278022;11760.235584686969;12286.385680716106;12364.258144511357;12382.133250672367 15:22:25 INFO - PROCESS | 21801 | |3;mootools.html;1510.9999999999995;1548.094364796594;1699.6175860431397;1808.457462761172;1821.9453416397512;7460.32857042866;8109.270165685087;8129.91870081299;8623.870641940375;8624.266937310329;8182.713605023825;8305.543195124266;8550.91449085509;8572.228499435065;8580.656773729042;2362.7755363240462;2394.8084153267696;2406.915757948472;2408.9879550602222;2410.8312418130736;2375.3942744600104;2386.809055275574;2398.3764221302413;2418.6492958521003;2428.174420696963;2360.091364824538;2380.2026321182425;2383.2492764779126;2408.1691816323428;2417.2869003643877;2322.814174866007;2331.475418030938;2339.82451316152;2348;2389.1876761901035;2381.0594815047957;2389.307100940725;2414.710234771821;2417.9274621761374;2443.1693224303644;8555.700550480704;8606.397552171351;8627.352948528885;8665.566721663892;8680.045195028542;5306.70813105279;5460.34475862899;5460.781568737246;5474.562035037187;5477.67133971959;3293.6870997255223;3329.7502687298547;3337.3158502506926;3344.0970937846887;3363.4618461046116;1121.6971417717252;1132.5696235430485;1135.8977692007759;1139.0488941733663;1139.5897476908306;11501;11819.468123934443;11829.408529573573;11832.585859494877;11850.525978960832;4610.907781844345;4638.95361046392;4838.322634831126;4872.926906096412;4881.389826271716;10232.53953572091;10272.794544109076;10283.588656453807;10291;10310.07209351147;5404.351477822686;5438.972805135949;5440.809571664972;5466.398696143421;5500.917486237709;4275.657947364203;4862.17343051682;4943.357363542788;4966.15575352191;5058.974705126451;4112.383142528644;4129.545749967501;4138.5790944385135;4248.830046798155;4257.91484170321;1342.0806747378078;1361.142480237444;1369.5754316162022;1374.8556401577691;1380.0684537936852;926.7127190570944;936.9672061477816;960.6637676813059;987.2250283527396;1021.402479549457;5636.379998200195;5856.297244330623;5934.287885453687;6005.3394126646035;6046.818595442144;980.2109302011806;988.7676396046924;1006.2101250518455;1055.9788804223872;1058.9576416943237;3972.5232972042963;4005.819738111792;4048.291548978917;4142.647874930664;4260.403543503912;9877.753056173653;10202.234832387601;10233.283670143019;10286.382817031003;10334.224933130045;10173.08442240202;10230.335028223142;10234.897651023395;10263.178945684327;10363.222758293008;7573.394128469819;7945.801354966172;7965.8805117923275;7966.482178658369;7971.282584567417;5923.970380148072;5931.970340148272;5942.910856337245;5993.850153746192;6058.485028772604;9153.816923661623;9181.265498759949;9187.816243675223;9206.769830754285;9332;9408.482533460725;9637.759056023655;9696.6121355145;9711.125998660154;9750.268729845431;7030;7307.707691692272;7431.331180193809;7675.769726908202;7774.416918731004;8291.419600627898;8319.792005199919;8373.748787536384;8400.201980811813;8420.5789710513;7094.148702155774;7178.5692858428665;7490.925090749241;7515.060617422822;7539.396848252017;7307.53673992192;7484.2141575136;7497.62511874415;7559.735409260649;7764.145943946274;6730.427913627396;6857.657117144223;6859.2454829969665;6866.485013623898;6897.379235868796;4934.259861020875;4987.975060124676;5018.498150185098;5135.768890399866;5142.871428214325;4786.497417771084;5014.974925125351;5023.1711767557945;5065.797368105382;5133.820316289061 15:22:25 INFO - PROCESS | 21801 | |4;prototype.html;346.49238865062676;365.80977891496417;366.8404244153792;367.3644594850908;369.7448760355355;5684.067417078192;5840.970795146029;5895.909256787492;5949.464548190667;5964.628135528831;5811.535077193825;5816.534677225823;5827.825165245049;5856.707164641762;5869.413058694128;4608.5852273295395;4614.492405835373;4619.145458090264;4621.428714237159;4630;4471.709338892978;4603.9769801151115;4606.309053641947;4608.870826647476;4617.607503362218;4536.3195520672;4546.931796023062;4551.544845515438;4561.156186105581;4581.473130589975;4548.135854187711;4560.771961401933;4590;4600.608948239404;4606;3811.8856434307013;3946.7434616750106;4005.4178599453053;4077.938830917539;4099.528554216274;5595.244641973363;5629.971850140723;5631.831045068655;5700.686462244575;5715.142728590703;5205.063088644042;5207.453217412193;5213.869653258661;5215.6609820361555;5232.110541208004;5836.256959229156;6033.577649564532;6067.575269731121;6075.848103797396;6084.148219249309;4378.627816635558;4384.802683879201;4391.780410979471;4395.692301538894;4409.316555933835;6173.59871608344;6309.873802523924;6328.65192414417;6378.489720822323;6387.457066149336;4451.421315229064;4464.464264288241;4469.664775141878;4480.9103817924115;4523.592876641118;4554.79297986034;4561.475430325489;4568.931466027946;4571.428571428572;4576.26779715244;5163.922541161885;5171.870703232374;5185.818496352609;5206.140986737221;5221.295125158131;5929.466348028698;6058.454739073504;6099.950024987506;6120.66336351496;6161.44546990773;1552.945646902353;1571.5206861907227;1572.606848287928;1580.5179420276927;1583.9208039597975;972.9075737804898;991.4546999150439;1014.6854475112591;1015.5480811039017;1017.862588550551;5225.242339860699;5255.369355677343;5260.789568417297;5263.631545791758;5292.682439053592;5438.564914806806;5468.878879829705;5477.616566840363;5507.614466987273;5512.228288039678;4913.557779799835;5188.377394712658;5240.4759524047295;5248.661591294195;5283.833628212491;2926.7561286453174;2937.3684657798676;2975.613170287849;2989.548570172438;3002.4145291667915;5661.433856614306;5680.488756011979;5685.403032681592;5709.314882214161;5726.599138060379;5292.338457692788;5540.529055030287;5565.914646643865;5570.721463926788;5581.09782912883;5577.358603760538;5649.576281778801;5657.886842263214;5675.716214189274;5711.257536520226;5147.944671342291;5456.554013186429;5493;5522.66863988162;5527.39198688152;5418.674879507243;5452.028644388897;5455.781768729206;5458.9454105458435;5476.91784623223;5599.348192283368;5602.299712535933;5691.857703557279;5694.402087780723;5709.800156994652;4049.2913740095955;4062.6140516652054;4153.127843152851;4505.549445055468;4520.570545798144;6138.785142519991;6194.721237544411;6260.843478913063;6274;6302;6154.846128846814;6155.599886007574;6158.32258451561;6171.9074213887725;6181.412765787243;6016.969915150571;6134.202553667995;6140.478059365004;6156.384361563808;6164.630122192503;6008.87982240344;6025.879482410415;6048.4556389923355;6066.937241337966;6080;6194.256689197326;6194.5973511721595;6201.844953876009;6228.283747369111;6240.344763799917;5910.379410161871;5988.640681559121;6021.698915054318;6026.233603997502;6034.185384973148 15:22:25 INFO - PROCESS | 21801 | |5;yui.html;701.5685353507591;763.7288762489317;775.9379249660028;806.5805780993883;864.2351518905771;13523.188608683473;14093.57719268421;14099.859001409983;14158.15051096935;14312.141271523717;14677.339519721612;14734.18961957092;14795.26023698816;14845.85154148461;14892.776608350883;731.5281643340043;866.3978534918234;885.707716453572;892.8125093730324;899.4603238057178;878.0911756332198;882.7042940614901;882.9293656507464;883.2227639677108;884.6992022712277;928.7956649537125;933.2394098809483;936.7704912296497;937.0722984245616;939.3612343606345;923.4367036107968;933.2673851026946;933.5285680731255;935.3125452792226;937.3251259093441;685.1538350137577;686.7356067913839;689.1695506914157;690.2924502385046;690.6132565763189;13601.115927464683;13622.86377136226;13671.521496747666;13678;13703;15504.147271900041;15583.766243506356;15805.762913556306;15841.683166336608;16228.756568651479;13010.544630937966;13177.538786142535;13419.194848309133;13433;13472.326383680776;4017.7243799440957;4069.8168582413864;4091.754494730326;4110.588941105895;4140.68944829139;86956;86996;87756.12243877607;88406.55796721039;93854.5307273466;12313.319110027409;12433.440495177738;12497.50009999608;12567.18313309632;12702.872971270353;23244;23259.7674023261;23299.18452854142;23323.41691457693;23391.532169356517;8635.13648635144;9171.81656366869;9267.953660231791;9542.666006689733;9595.184409325146;4901.681390709592;5029.245613158056;5066.974665126724;5080.517350851663;5290.285811415487;3624.7643903146213;3739.0652336915773;3764.3036038333;3773.2453509298252;3787.4886890270013;574.9798757043484;651.6122906870404;653.5490511547017;655.1646650520529;657.1457105762489;649.9415052645285;709.925457826931;718.007529106733;758.3553979117706;771.6797529025504;10111.292209545409;10308.536115874804;10398.428086455318;10453.26827122094;10534.57861685524;750.3884334267555;759.3052357093309;775.4998026273136;780.6604127204685;791.1179035375629;4922.704637721677;5167.328247327823;5191.454897235812;5248.501392367795;5272.420033796279;130167.34916325357;130644;132849.33575332255;133803;137585;66948;70950;92304.53847730852;94948;102033;55520;91195;92270;93246.53376733072;95086.52456737672;10216.59133634676;10250.282480226313;10471.528781205016;10644.946775266075;10723.195760318164;48493;50197.74901125617;55221.1716824256;58360.70819645875;58364.12453813111;68569;69287.30712692809;78061;78845;79346.6032669833;13572.796408054084;13747.862521375058;13848.861511385161;14146.858531414555;14480.203588802717;15789.763153552476;15996.360145594512;16224.35102595883;16489.34042638329;16729.749053764448;14809.703805924037;15123.31945062497;15317.846821531642;15363.308651110503;16195.43315983935;14135;14299;14309.928450357682;14399.78400323975;14776.113433194043;14705.779727338264;14857.182854943081;14966.04031566896;15076.924615376853;15167.089974601558;12272.386380680751;13025.869741302844;13079.084464087804;13134.40895159701;13304.933475332562;12566.434510447234;12794.232346059267;12969.740605187655;13062.150960187557;13153.802692959805 15:22:25 INFO - PROCESS | 21801 | __end_tp_report 15:22:25 INFO - PROCESS | 21801 | __start_cc_report 15:22:25 INFO - PROCESS | 21801 | _x_x_mozilla_cycle_collect,358 15:22:25 INFO - PROCESS | 21801 | __end_cc_report 15:22:25 INFO - PROCESS | 21801 | __startTimestamp1475187745425__endTimestamp 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | ------- Summary: start ------- 15:22:25 INFO - PROCESS | 21801 | Number of tests: 6 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | [#0] dojo.html Cycles:165 Average:5690.14 Median:5955.17 stddev:649.28 (10.9%) stddev-sans-first:622.60 15:22:25 INFO - PROCESS | 21801 | Values: 3257.7 3269.1 3279.1 3286.3 3306.9 5717.2 5797.7 5815.3 5823.0 5841.8 5655.5 5707.3 5710.4 5716.5 5724.5 5181.7 5202.0 5212.8 5243.6 5254.6 5244.4 5247.6 5251.9 5251.9 5289.2 5103.9 5122.1 5224.2 5231.5 5240.1 5104.5 5213.9 5226.4 5232.8 5266.8 5131.8 5167.6 5168.7 5184.2 5186.8 5524.1 5545.4 5617.0 5676.1 5740.5 5955.2 6030.4 6043.3 6056.9 6076.5 6080.2 6080.9 6082.0 6092.5 6106.1 5532.0 5604.5 5642.0 5650.2 5664.9 6170.6 6209.7 6249.2 6251.6 6254.3 5865.9 5868.7 5873.2 5876.7 5898.8 5838.6 5909.3 5965.5 5967.5 6062.4 6030.5 6142.4 6144.8 6151.6 6156.4 6169.5 6171.7 6185.3 6186.8 6198.1 4548.6 4641.1 4734.6 4742.1 4751.6 4137.5 4197.1 4203.2 4221.9 4228.5 5947.1 5957.4 5961.3 5966.2 5987.8 5940.6 6069.2 6238.7 6240.2 6245.1 5906.5 5936.8 5944.5 5959.0 5978.1 5299.2 5316.0 5326.5 5331.8 5345.5 6130.2 6146.0 6249.6 6394.7 6429.2 6111.5 6197.7 6203.6 6206.2 6207.9 6344.8 6392.6 6406.2 6408.4 6418.7 5768.8 5919.9 6040.1 6080.1 6093.2 6070.8 6137.9 6145.8 6153.3 6161.8 6009.2 6018.5 6038.2 6043.3 6055.4 5816.6 5992.6 5997.1 6002.2 6039.2 6043.2 6068.6 6073.7 6084.4 6110.1 6041.4 6044.6 6065.6 6118.2 6131.4 5581.4 5722.5 5968.8 5989.8 6000.2 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | [#1] ext.html Cycles:180 Average:65961.66 Median:46687.18 stddev:130420.71 (279.4%) stddev-sans-first:130694.22 15:22:25 INFO - PROCESS | 21801 | Values: 589.8 612.5 645.4 662.4 698.8 41564.8 47298.5 47347.8 47511.0 47553.8 47355.5 48160.5 48229.0 48249.0 48335.3 9091.8 9223.0 9238.2 9244.5 9277.0 9125.9 9185.7 9212.3 9225.9 9259.3 9230.6 9283.8 9284.5 9291.3 9294.0 9209.1 9231.0 9247.1 9248.0 9251.4 9218.2 9222.4 9230.3 9269.4 9296.8 44960.6 45657.0 45692.0 45692.1 45706.3 4238.4 4630.8 4767.6 4768.4 4848.8 36106.6 36206.8 36334.3 36534.8 37439.6 4770.5 4770.6 4835.5 4841.4 4876.9 369983.0 370645.0 371654.0 374995.0 375648.0 65602.0 65926.3 65981.0 66015.0 66030.0 40153.0 41395.6 41455.2 67946.7 68033.3 18276.9 18300.1 18334.0 18447.0 18494.9 15039.2 15137.1 15194.7 15227.1 15227.8 21291.7 21384.0 21465.2 21527.7 21623.4 7538.3 7654.6 7764.7 7780.5 7920.6 1054.5 1078.5 1079.3 1089.0 1115.1 34350.3 34363.3 34364.3 34618.7 34753.1 1174.7 1190.1 1196.3 1225.5 1247.6 17944.4 18165.5 18234.6 18269.1 18427.4 581126.0 590803.0 591069.0 591381.0 591737.0 66414.7 66923.7 67043.0 67137.0 67348.0 1458.9 1462.2 1482.2 1495.2 1498.2 33424.5 33593.0 33761.5 33882.3 33910.0 57922.4 58410.0 58535.7 58617.0 58665.4 486514.0 488835.0 489192.0 490546.0 491937.0 31382.7 32024.7 32296.2 32525.7 32544.2 53238.2 53427.7 53789.5 54218.2 54734.7 44190.3 44696.2 46459.5 47168.5 48144.8 45144.5 45587.3 46243.3 46493.1 48013.0 44790.3 46301.0 46400.8 46881.3 47956.8 38345.2 38603.4 39080.6 39605.2 39743.4 30501.5 30600.7 30691.8 30765.0 30965.8 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | [#2] jquery.html Cycles:180 Average:31318.95 Median:25202.50 stddev:89159.54 (353.8%) stddev-sans-first:89379.46 15:22:25 INFO - PROCESS | 21801 | Values: 412.3 421.6 436.2 440.9 444.4 18991.7 20675.6 20958.9 21180.9 21380.6 20683.5 21064.9 21074.4 21651.6 21712.5 5802.3 6003.4 6008.8 6011.2 6016.8 5943.9 5961.9 5992.9 6007.1 6009.1 5743.3 5917.8 5919.6 5954.9 5955.8 5869.3 5871.3 5910.3 5923.9 5929.2 5164.8 5262.2 5311.8 5317.9 5324.1 25091.0 25314.0 25404.0 25422.0 25546.9 2711.6 2797.5 2835.1 3020.5 3136.4 16005.4 16194.7 16206.4 16294.8 16650.8 2031.6 2087.0 2110.8 2111.0 2185.9 80911.0 81562.0 82100.0 83042.0 84370.6 11611.8 11622.7 11794.8 12072.0 12155.9 16548.5 16584.8 16594.3 16609.2 16654.0 8749.7 9166.6 9218.1 9365.3 9405.0 8773.1 8880.8 8912.2 9079.5 9173.8 6991.2 7268.5 7279.7 7312.7 7314.3 2084.4 2088.4 2112.5 2177.1 2191.7 1026.5 1036.8 1039.5 1069.5 1134.9 20595.7 20979.9 20995.8 21047.8 21598.7 1067.2 1091.1 1108.6 1110.9 1171.4 11625.8 12081.5 12132.8 12278.6 12305.3 538602.0 542101.0 542138.0 543563.0 552873.0 78070.6 81992.6 82347.2 82877.6 83089.2 1072.9 1078.6 1079.2 1089.4 1089.4 18042.8 19114.9 19207.2 19209.2 19537.6 45110.3 45285.0 45903.3 46167.5 47611.0 60102.0 62496.7 63798.4 64370.4 65482.7 9014.5 9334.5 9547.9 9686.9 9720.8 12623.4 13299.4 13778.0 14327.8 14414.5 10855.7 12317.9 12539.8 12547.8 12776.8 11292.5 11750.9 11834.6 12033.5 12233.0 11926.9 12036.3 12464.3 12503.2 12619.8 9309.6 9378.7 9433.3 9592.0 9701.5 11122.9 11760.2 12286.4 12364.3 12382.1 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | [#3] mootools.html Cycles:180 Average:5669.55 Median:5016.74 stddev:3081.35 (61.4%) stddev-sans-first:3074.15 15:22:25 INFO - PROCESS | 21801 | Values: 1511.0 1548.1 1699.6 1808.5 1821.9 7460.3 8109.3 8129.9 8623.9 8624.3 8182.7 8305.5 8550.9 8572.2 8580.7 2362.8 2394.8 2406.9 2409.0 2410.8 2375.4 2386.8 2398.4 2418.6 2428.2 2360.1 2380.2 2383.2 2408.2 2417.3 2322.8 2331.5 2339.8 2348.0 2389.2 2381.1 2389.3 2414.7 2417.9 2443.2 8555.7 8606.4 8627.4 8665.6 8680.0 5306.7 5460.3 5460.8 5474.6 5477.7 3293.7 3329.8 3337.3 3344.1 3363.5 1121.7 1132.6 1135.9 1139.0 1139.6 11501.0 11819.5 11829.4 11832.6 11850.5 4610.9 4639.0 4838.3 4872.9 4881.4 10232.5 10272.8 10283.6 10291.0 10310.1 5404.4 5439.0 5440.8 5466.4 5500.9 4275.7 4862.2 4943.4 4966.2 5059.0 4112.4 4129.5 4138.6 4248.8 4257.9 1342.1 1361.1 1369.6 1374.9 1380.1 926.7 937.0 960.7 987.2 1021.4 5636.4 5856.3 5934.3 6005.3 6046.8 980.2 988.8 1006.2 1056.0 1059.0 3972.5 4005.8 4048.3 4142.6 4260.4 9877.8 10202.2 10233.3 10286.4 10334.2 10173.1 10230.3 10234.9 10263.2 10363.2 7573.4 7945.8 7965.9 7966.5 7971.3 5924.0 5932.0 5942.9 5993.9 6058.5 9153.8 9181.3 9187.8 9206.8 9332.0 9408.5 9637.8 9696.6 9711.1 9750.3 7030.0 7307.7 7431.3 7675.8 7774.4 8291.4 8319.8 8373.7 8400.2 8420.6 7094.1 7178.6 7490.9 7515.1 7539.4 7307.5 7484.2 7497.6 7559.7 7764.1 6730.4 6857.7 6859.2 6866.5 6897.4 4934.3 4988.0 5018.5 5135.8 5142.9 4786.5 5015.0 5023.2 5065.8 5133.8 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | [#4] prototype.html Cycles:180 Average:4949.60 Median:5463.91 stddev:1422.42 (26.0%) stddev-sans-first:1383.82 15:22:25 INFO - PROCESS | 21801 | Values: 346.5 365.8 366.8 367.4 369.7 5684.1 5841.0 5895.9 5949.5 5964.6 5811.5 5816.5 5827.8 5856.7 5869.4 4608.6 4614.5 4619.1 4621.4 4630.0 4471.7 4604.0 4606.3 4608.9 4617.6 4536.3 4546.9 4551.5 4561.2 4581.5 4548.1 4560.8 4590.0 4600.6 4606.0 3811.9 3946.7 4005.4 4077.9 4099.5 5595.2 5630.0 5631.8 5700.7 5715.1 5205.1 5207.5 5213.9 5215.7 5232.1 5836.3 6033.6 6067.6 6075.8 6084.1 4378.6 4384.8 4391.8 4395.7 4409.3 6173.6 6309.9 6328.7 6378.5 6387.5 4451.4 4464.5 4469.7 4480.9 4523.6 4554.8 4561.5 4568.9 4571.4 4576.3 5163.9 5171.9 5185.8 5206.1 5221.3 5929.5 6058.5 6100.0 6120.7 6161.4 1552.9 1571.5 1572.6 1580.5 1583.9 972.9 991.5 1014.7 1015.5 1017.9 5225.2 5255.4 5260.8 5263.6 5292.7 5438.6 5468.9 5477.6 5507.6 5512.2 4913.6 5188.4 5240.5 5248.7 5283.8 2926.8 2937.4 2975.6 2989.5 3002.4 5661.4 5680.5 5685.4 5709.3 5726.6 5292.3 5540.5 5565.9 5570.7 5581.1 5577.4 5649.6 5657.9 5675.7 5711.3 5147.9 5456.6 5493.0 5522.7 5527.4 5418.7 5452.0 5455.8 5458.9 5476.9 5599.3 5602.3 5691.9 5694.4 5709.8 4049.3 4062.6 4153.1 4505.5 4520.6 6138.8 6194.7 6260.8 6274.0 6302.0 6154.8 6155.6 6158.3 6171.9 6181.4 6017.0 6134.2 6140.5 6156.4 6164.6 6008.9 6025.9 6048.5 6066.9 6080.0 6194.3 6194.6 6201.8 6228.3 6240.3 5910.4 5988.6 6021.7 6026.2 6034.2 15:22:25 INFO - PROCESS | 21801 | 15:22:25 INFO - PROCESS | 21801 | [#5] yui.html Cycles:180 Average:21809.60 Median:3902.61 stddev:31550.57 (808.4%) stddev-sans-first:31599.26 15:22:25 INFO - PROCESS | 21801 | Values: 701.6 763.7 775.9 806.6 864.2 13523.2 14093.6 14099.9 14158.2 14312.1 14677.3 14734.2 14795.3 14845.9 14892.8 731.5 866.4 885.7 892.8 899.5 878.1 882.7 882.9 883.2 884.7 928.8 933.2 936.8 937.1 939.4 923.4 933.3 933.5 935.3 937.3 685.2 686.7 689.2 690.3 690.6 13601.1 13622.9 13671.5 13678.0 13703.0 15504.1 15583.8 15805.8 15841.7 16228.8 13010.5 13177.5 13419.2 13433.0 13472.3 4017.7 4069.8 4091.8 4110.6 4140.7 86956.0 86996.0 87756.1 88406.6 93854.5 12313.3 12433.4 12497.5 12567.2 12702.9 23244.0 23259.8 23299.2 23323.4 23391.5 8635.1 9171.8 9268.0 9542.7 9595.2 4901.7 5029.2 5067.0 5080.5 5290.3 3624.8 3739.1 3764.3 3773.2 3787.5 575.0 651.6 653.5 655.2 657.1 649.9 709.9 718.0 758.4 771.7 10111.3 10308.5 10398.4 10453.3 10534.6 750.4 759.3 775.5 780.7 791.1 4922.7 5167.3 5191.5 5248.5 5272.4 130167.3 130644.0 132849.3 133803.0 137585.0 66948.0 70950.0 92304.5 94948.0 102033.0 55520.0 91195.0 92270.0 93246.5 95086.5 10216.6 10250.3 10471.5 10644.9 10723.2 48493.0 50197.7 55221.2 58360.7 58364.1 68569.0 69287.3 78061.0 78845.0 79346.6 13572.8 13747.9 13848.9 14146.9 14480.2 15789.8 15996.4 16224.4 16489.3 16729.7 14809.7 15123.3 15317.8 15363.3 16195.4 14135.0 14299.0 14309.9 14399.8 14776.1 14705.8 14857.2 14966.0 15076.9 15167.1 12272.4 13025.9 13079.1 13134.4 13304.9 12566.4 12794.2 12969.7 13062.2 13153.8 15:22:25 INFO - PROCESS | 21801 | -------- Summary: end -------- 15:22:25 INFO - PROCESS | 21801 | 15:22:26 INFO - TEST-INFO | 21801: exit 0 15:22:26 INFO - TEST-OK | dromaeo_css | took 1110848ms 15:22:26 INFO - TEST-START | kraken 15:22:26 INFO - operating with platform_type : linux_ 15:22:26 INFO - Initialising browser for kraken test... 15:22:26 INFO - TEST-INFO | started process 22042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpASVrjM/profile http://localhost:42047/getInfo.html) 15:22:30 INFO - PROCESS | 22042 | __metrics Screen width/height:1600/1200 15:22:30 INFO - PROCESS | 22042 | colorDepth:24 15:22:30 INFO - PROCESS | 22042 | Browser inner width/height: 1024/697 15:22:30 INFO - PROCESS | 22042 | __metrics 15:22:31 ERROR - PROCESS | 22042 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:22:32 INFO - TEST-INFO | 22042: exit 0 15:22:32 INFO - Browser initialized. 15:22:32 INFO - Running cycle 1/1 for kraken test... 15:22:32 INFO - TEST-INFO | started process 22168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpASVrjM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:44 INFO - PROCESS | 22168 | RSS: Main: 150351872 15:22:44 INFO - PROCESS | 22168 | 15:22:46 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42047/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:47 INFO - PROCESS | 22168 | RSS: Main: 156901376 15:22:47 INFO - PROCESS | 22168 | 15:22:50 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42047/tests/kraken/driver.html?testName=audio-dft) 15:22:50 INFO - PROCESS | 22168 | RSS: Main: 155361280 15:22:50 INFO - PROCESS | 22168 | 15:22:53 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42047/tests/kraken/driver.html?testName=audio-fft) 15:22:54 INFO - PROCESS | 22168 | RSS: Main: 155582464 15:22:54 INFO - PROCESS | 22168 | 15:22:56 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42047/tests/kraken/driver.html?testName=audio-oscillator) 15:22:57 INFO - PROCESS | 22168 | RSS: Main: 156524544 15:22:57 INFO - PROCESS | 22168 | 15:22:59 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:22:59 INFO - PROCESS | 22168 | RSS: Main: 156160000 15:22:59 INFO - PROCESS | 22168 | 15:23:02 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42047/tests/kraken/driver.html?testName=imaging-darkroom) 15:23:03 INFO - PROCESS | 22168 | RSS: Main: 155963392 15:23:03 INFO - PROCESS | 22168 | 15:23:06 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42047/tests/kraken/driver.html?testName=imaging-desaturate) 15:23:07 INFO - PROCESS | 22168 | RSS: Main: 156598272 15:23:07 INFO - PROCESS | 22168 | 15:23:10 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42047/tests/kraken/driver.html?testName=json-parse-financial) 15:23:11 INFO - PROCESS | 22168 | RSS: Main: 156262400 15:23:11 INFO - PROCESS | 22168 | 15:23:12 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:23:13 INFO - PROCESS | 22168 | RSS: Main: 155553792 15:23:13 INFO - PROCESS | 22168 | 15:23:14 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:23:15 INFO - PROCESS | 22168 | RSS: Main: 155815936 15:23:15 INFO - PROCESS | 22168 | 15:23:17 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:23:18 INFO - PROCESS | 22168 | RSS: Main: 156143616 15:23:18 INFO - PROCESS | 22168 | 15:23:20 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:23:21 INFO - PROCESS | 22168 | RSS: Main: 156180480 15:23:21 INFO - PROCESS | 22168 | 15:23:24 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:24 INFO - PROCESS | 22168 | RSS: Main: 156540928 15:23:24 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | Cycle 1(1): loaded http://localhost:42047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42047/tests/kraken/driver.html?testName=ai-astar) 15:23:26 INFO - PROCESS | 22168 | RSS: Main: 158658560 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | __start_tp_report 15:23:26 INFO - PROCESS | 22168 | _x_x_mozilla_page_load 15:23:26 INFO - PROCESS | 22168 | _x_x_mozilla_page_load_details 15:23:26 INFO - PROCESS | 22168 | |i|pagename|runs| 15:23:26 INFO - PROCESS | 22168 | |0;ai-astar;99;111;104;113;111;111;109;111;111;110 15:23:26 INFO - PROCESS | 22168 | |1;audio-beat-detection;155;119;152;175;117;138;146;119;175;119 15:23:26 INFO - PROCESS | 22168 | |2;audio-dft;162;160;162;163;163;162;162;162;162;160 15:23:26 INFO - PROCESS | 22168 | |3;audio-fft;74;74;75;181;77;73;75;76;169;75 15:23:26 INFO - PROCESS | 22168 | |4;audio-oscillator;84;84;142;84;84;84;140;83;84;146 15:23:26 INFO - PROCESS | 22168 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;118;118;117 15:23:26 INFO - PROCESS | 22168 | |6;imaging-darkroom;147;146;148;147;147;147;147;147;146;147 15:23:26 INFO - PROCESS | 22168 | |7;imaging-desaturate;95;95;95;97;96;95;95;95;96;96 15:23:26 INFO - PROCESS | 22168 | |8;json-parse-financial;49;50;49;50;50;52;50;50;53;50 15:23:26 INFO - PROCESS | 22168 | |9;json-stringify-tinderbox;60;60;60;62;61;60;60;60;63;61 15:23:26 INFO - PROCESS | 22168 | |10;stanford-crypto-aes;72;72;72;78;72;73;72;72;77;72 15:23:26 INFO - PROCESS | 22168 | |11;stanford-crypto-ccm;119;124;120;118;120;118;131;117;156;117 15:23:26 INFO - PROCESS | 22168 | |12;stanford-crypto-pbkdf2;162;164;147;150;151;152;156;150;150;151 15:23:26 INFO - PROCESS | 22168 | |13;stanford-crypto-sha256-iterative;63;63;62;61;63;62;61;64;60;59 15:23:26 INFO - PROCESS | 22168 | __end_tp_report 15:23:26 INFO - PROCESS | 22168 | __start_cc_report 15:23:26 INFO - PROCESS | 22168 | _x_x_mozilla_cycle_collect,859 15:23:26 INFO - PROCESS | 22168 | __end_cc_report 15:23:26 INFO - PROCESS | 22168 | __startTimestamp1475187806495__endTimestamp 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | ------- Summary: start ------- 15:23:26 INFO - PROCESS | 22168 | Number of tests: 14 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.24 (3.8%) stddev-sans-first:2.52 15:23:26 INFO - PROCESS | 22168 | Values: 99.0 111.0 104.0 113.0 111.0 111.0 109.0 111.0 111.0 110.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:149.00 stddev:22.82 (15.3%) stddev-sans-first:23.68 15:23:26 INFO - PROCESS | 22168 | Values: 155.0 119.0 152.0 175.0 117.0 138.0 146.0 119.0 175.0 119.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 15:23:26 INFO - PROCESS | 22168 | Values: 162.0 160.0 162.0 163.0 163.0 162.0 162.0 162.0 162.0 160.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.00 stddev:42.33 (56.4%) stddev-sans-first:44.21 15:23:26 INFO - PROCESS | 22168 | Values: 74.0 74.0 75.0 181.0 77.0 73.0 75.0 76.0 169.0 75.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:84.00 stddev:28.45 (33.9%) stddev-sans-first:29.46 15:23:26 INFO - PROCESS | 22168 | Values: 84.0 84.0 142.0 84.0 84.0 84.0 140.0 83.0 84.0 146.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:23:26 INFO - PROCESS | 22168 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:23:26 INFO - PROCESS | 22168 | Values: 147.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 15:23:26 INFO - PROCESS | 22168 | Values: 95.0 95.0 95.0 97.0 96.0 95.0 95.0 95.0 96.0 96.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:1.25 (2.5%) stddev-sans-first:1.24 15:23:26 INFO - PROCESS | 22168 | Values: 49.0 50.0 49.0 50.0 50.0 52.0 50.0 50.0 53.0 50.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:1.06 (1.8%) stddev-sans-first:1.09 15:23:26 INFO - PROCESS | 22168 | Values: 60.0 60.0 60.0 62.0 61.0 60.0 60.0 60.0 63.0 61.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:72.00 stddev:2.30 (3.2%) stddev-sans-first:2.40 15:23:26 INFO - PROCESS | 22168 | Values: 72.0 72.0 72.0 78.0 72.0 73.0 72.0 72.0 77.0 72.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:120.00 stddev:12.02 (10.0%) stddev-sans-first:12.61 15:23:26 INFO - PROCESS | 22168 | Values: 119.0 124.0 120.0 118.0 120.0 118.0 131.0 117.0 156.0 117.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:151.50 stddev:5.60 (3.7%) stddev-sans-first:4.97 15:23:26 INFO - PROCESS | 22168 | Values: 162.0 164.0 147.0 150.0 151.0 152.0 156.0 150.0 150.0 151.0 15:23:26 INFO - PROCESS | 22168 | 15:23:26 INFO - PROCESS | 22168 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.50 stddev:1.55 (2.5%) stddev-sans-first:1.58 15:23:26 INFO - PROCESS | 22168 | Values: 63.0 63.0 62.0 61.0 63.0 62.0 61.0 64.0 60.0 59.0 15:23:26 INFO - PROCESS | 22168 | -------- Summary: end -------- 15:23:26 INFO - PROCESS | 22168 | 15:23:27 INFO - TEST-INFO | 22168: exit 0 15:23:27 INFO - TEST-OK | kraken | took 61314ms 15:23:27 INFO - SUITE-END | took 1172s 15:23:27 INFO - Completed test suite (00:19:32) 15:23:27 INFO - javascript benchmark 15:23:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7703.829856518131, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3257.674232576742, 3269.051974927271, 3279.147421670365, 3286.3098749262654, 3306.8677252909883, 5717.2281741964825, 5797.739101740426, 5815.331236907757, 5823.0, 5841.766329346821, 5655.5475561955045, 5707.343655479621, 5710.428957104287, 5716.514096301809, 5724.542036637069, 5181.740912954356, 5201.973990130063, 5212.765425555859, 5243.606729495303, 5254.632175747699, 5244.396894357141, 5247.580193584504, 5251.86870328241, 5251.921221181686, 5289.20661900716, 5103.872403189913, 5122.129238029525, 5224.1902505111575, 5231.476852314776, 5240.109181439165, 5104.464031276718, 5213.947860521384, 5226.3989641191365, 5232.843014709565, 5266.7629956652045, 5131.846044618667, 5167.638265321429, 5168.741562921877, 5184.196449550326, 5186.766595503212, 5524.14375771756, 5545.417731138253, 5617.0, 5676.091825307973, 5740.54075673945, 5955.166276721219, 6030.396960303979, 6043.335233124353, 6056.909146362808, 6076.544259180535, 6080.2399700037495, 6080.908786368208, 6081.969590152021, 6092.45167934888, 6106.084087386883, 5532.031894418501, 5604.495595396434, 5642.012647786621, 5650.180723795027, 5664.858378540528, 6170.568060235741, 6209.6895155242055, 6249.1563638908165, 6251.562390632612, 6254.312025677172, 5865.88268234633, 5868.735906884201, 5873.177755114288, 5876.676782776988, 5898.8230353089475, 5838.562107841929, 5909.320428150818, 5965.492933100735, 5967.492763115184, 6062.393760623991, 6030.48740857032, 6142.406692085091, 6144.815655530341, 6151.569390142647, 6156.353582873734, 6169.475594574512, 6171.722272497748, 6185.257769067651, 6186.783462578788, 6198.132261483396, 4548.567886050886, 4641.094986477605, 4734.573888350065, 4742.07529531738, 4751.596114330251, 4137.50349958007, 4197.097624010852, 4203.180379825966, 4221.873343799691, 4228.513720922072, 5947.1079338099635, 5957.434043765836, 5961.314448838352, 5966.161178077604, 5987.790427335022, 5940.6435613863305, 6069.2110025696375, 6238.656873871981, 6240.157578726814, 6245.094461303085, 5906.468417842329, 5936.821895343147, 5944.494717948936, 5959.046552551657, 5978.103284507359, 5299.205119232146, 5316.0, 5326.493983071602, 5331.840044798662, 5345.518903298722, 6130.1724267224245, 6145.9692701536205, 6249.593776404519, 6394.71223794921, 6429.228492580826, 6111.500579230309, 6197.690115494117, 6203.627782333075, 6206.224221972254, 6207.906881396692, 6344.777932772331, 6392.648404337806, 6406.199225096863, 6408.423241908251, 6418.743250269937, 5768.826935191951, 5919.911201331897, 6040.063790112539, 6080.148779170831, 6093.238345206849, 6070.757169713339, 6137.9286238596105, 6145.8156255312415, 6153.261608606996, 6161.845953851011, 6009.218801555945, 6018.518518518596, 6038.184845046038, 6043.335233124265, 6055.364186760326, 5816.592838501433, 5992.610480318765, 5997.13041608973, 6002.189704390026, 6039.184710064085, 6043.244594425697, 6068.6358818471035, 6073.726682299395, 6084.421979911901, 6110.114033465212, 6041.395860414099, 6044.576879618385, 6065.636061836304, 6118.235220597426, 6131.386861314011, 5581.413951535193, 5722.484976352148, 5968.7612495501435, 5989.8203053908455, 6000.159977603052], "value": 5645.931997422119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.764094362255, 612.4732729852327, 645.3772109913933, 662.4038365471075, 698.7868700046483, 41564.79217603912, 47298.52701472984, 47347.76326118373, 47511.0, 47553.81115472115, 47355.526444735544, 48160.51839481604, 48229.0, 48249.0, 48335.27497087546, 9091.77270568236, 9223.031581683927, 9238.214751746109, 9244.537773111317, 9276.953615231914, 9125.863112053325, 9185.724428267129, 9212.309076819232, 9225.861612075823, 9259.259259259277, 9230.58462369195, 9283.814323713521, 9284.535773211346, 9291.303152263574, 9293.95353023234, 9209.079092090771, 9231.030741772118, 9247.12152345526, 9247.953760231223, 9251.352405331629, 9218.216451601622, 9222.40054396462, 9230.307726920508, 9269.351145419823, 9296.814063718688, 44960.550394495964, 45657.0, 45692.0, 45692.086158276645, 45706.31440528395, 4238.364245363189, 4630.791614377327, 4767.642426817968, 4768.403949506312, 4848.757562121879, 36106.638933610855, 36206.818965905266, 36334.27331453356, 36534.817325913464, 37439.62560374389, 4770.522947705236, 4770.61835053195, 4835.492273311287, 4841.419029716457, 4876.853694389174, 369983.0, 370645.0, 371654.0, 374995.0, 375648.0, 65602.0, 65926.34073659201, 65981.0, 66015.0, 66030.0, 40153.0, 41395.586044139774, 41455.1708965819, 67946.66026669835, 68033.2786688527, 18276.908615457105, 18300.084995750425, 18334.0, 18446.98541580199, 18494.907525462557, 15039.172845493604, 15137.091774493565, 15194.696106077816, 15227.086374817325, 15227.847721522643, 21291.68062479064, 21384.0, 21465.248716294856, 21527.67708484374, 21623.351299460726, 7538.266198774312, 7654.617269136521, 7764.650590723431, 7780.533168009937, 7920.564368959647, 1054.488573042074, 1078.5362294213564, 1079.287670137721, 1088.9509972051276, 1115.1469126118525, 34350.31299374049, 34363.31273374568, 34364.31271374559, 34618.65381346154, 34753.13117172091, 1174.723939874129, 1190.1193117093462, 1196.347990345264, 1225.497546006151, 1247.5758242197696, 17944.41782462875, 18165.54586135357, 18234.635307293778, 18269.106779744918, 18427.447176584723, 581126.0, 590803.0, 591069.0, 591381.0, 591737.0, 66414.66792666005, 66923.66538167278, 67043.0, 67137.0, 67348.0, 1458.9197594132213, 1462.166565057928, 1482.1773915477013, 1495.2000679636342, 1498.168516473346, 33424.498632520044, 33593.0, 33761.493577595866, 33882.32235355328, 33910.0, 57922.4207757917, 58410.0, 58535.707321463124, 58617.0, 58665.41334586599, 486514.0, 488835.0, 489192.0, 490546.0, 491937.0, 31382.68617313889, 32024.6797532031, 32296.192595185308, 32525.674743252264, 32544.186395340304, 53238.2014269794, 53427.732861337, 53789.46210537844, 54218.186727199914, 54734.726326368116, 44190.33714494349, 44696.19667202518, 46459.53540464687, 47168.528314716415, 48144.75927620479, 45144.54855451403, 45587.31619025651, 46243.3063504041, 46493.07013859636, 48013.0, 44790.3281450772, 46301.0, 46400.767996159804, 46881.296780549004, 47956.760216198694, 38345.23309533738, 38603.42094868523, 39080.609193907694, 39605.2078958425, 39743.403848942864, 30501.54247686242, 30600.693993059784, 30691.846540767154, 30765.0, 30965.845170774002], "value": 21966.605431723186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.2682239025727, 421.57210431412125, 436.1538615086732, 440.8743508100191, 444.44444444444446, 18991.71512427313, 20675.586488270226, 20958.89520552397, 21180.89409552952, 21380.57238855222, 20683.521534925538, 21064.8946755266, 21074.367768966917, 21651.566968660656, 21712.457188570253, 5802.274715660532, 6003.429674180968, 6008.8497787555225, 6011.158437818709, 6016.8495787605225, 5943.88112237755, 5961.85095372617, 5992.880142397149, 6007.098935159717, 6009.09863520471, 5743.3108027036815, 5917.792877249297, 5919.585629005971, 5954.880902381949, 5955.821325360246, 5869.325027621814, 5871.266091738533, 5910.261217347832, 5923.881522369528, 5929.229200203989, 5164.767585458663, 5262.158054711266, 5311.840644780663, 5317.867053323659, 5324.148136298212, 25091.0, 25314.0, 25404.0, 25422.0, 25546.87226563874, 2711.5797051457057, 2797.5384061629807, 2835.135283738459, 3020.5318175682582, 3136.3570468053995, 16005.439809606607, 16194.676106477922, 16206.432774852823, 16294.755578666329, 16650.83349166505, 2031.6444622191057, 2086.968695469569, 2110.778368271325, 2111.0183764549406, 2185.8961224581644, 80911.0, 81562.0, 82100.0, 83042.0, 84370.57814710887, 11611.825822612667, 11622.6513204604, 11794.764104717857, 12072.0, 12155.939220304019, 16548.503544893672, 16584.75122873158, 16594.336226551044, 16609.169541522875, 16654.0, 8749.737507874774, 9166.587503562356, 9218.124278193562, 9365.250779937589, 9405.012473690163, 8773.122687731176, 8880.777980550538, 8912.197902188704, 9079.500627465553, 9173.770655733526, 6991.196012458632, 7268.454865884974, 7279.745208917662, 7312.707491700379, 7314.342828585707, 2084.395525297677, 2088.3734879536078, 2112.4930016796166, 2177.107385971744, 2191.6959409151527, 1026.5414332673354, 1036.8030074286012, 1039.4542864995938, 1069.4759567811716, 1134.9205555611193, 20595.691064634044, 20979.895100524398, 20995.79004209969, 21047.78952210489, 21598.676019859715, 1067.1676092647747, 1091.0562363555468, 1108.6175269531998, 1110.9055730262858, 1171.37916904041, 11625.76748465026, 12081.45633446497, 12132.757344853053, 12278.631641050782, 12305.323207223688, 538602.0, 542101.0, 542138.0, 543563.0, 552873.0, 78070.6096469514, 81992.59003705063, 82347.17652823395, 82877.58561207155, 83089.16910830814, 1072.922893006572, 1078.6332646900091, 1079.2283517285023, 1089.3572792052569, 1089.3844977587796, 18042.819571804113, 19114.904425477784, 19207.231710731416, 19209.231630734615, 19537.63236573483, 45110.32334514919, 45285.0, 45903.3114503276, 46167.538324616326, 47611.0, 60102.0, 62496.68751656394, 63798.362016379244, 64370.35629643644, 65482.67258663676, 9014.549272536216, 9334.533273336441, 9547.856782148134, 9686.903130968882, 9720.75698107553, 12623.36883155857, 13299.401526931118, 13777.966652501304, 14327.78508322355, 14414.495492657707, 10855.674329769803, 12317.876821231674, 12539.811902821648, 12547.811782823082, 12776.808347874603, 11292.49183786748, 11750.882491174978, 11834.644960651194, 12033.45849436795, 12233.0, 11926.880731192578, 12036.338001410006, 12464.252144871336, 12503.187292825936, 12619.81070283928, 9309.627614895599, 9378.718638440858, 9433.339666223574, 9591.952040239754, 9701.514924253901, 11122.944385278022, 11760.235584686969, 12286.385680716106, 12364.258144511357, 12382.133250672367], "value": 10082.638073662974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.9999999999995, 1548.094364796594, 1699.6175860431397, 1808.457462761172, 1821.9453416397512, 7460.32857042866, 8109.270165685087, 8129.91870081299, 8623.870641940375, 8624.266937310329, 8182.713605023825, 8305.543195124266, 8550.91449085509, 8572.228499435065, 8580.656773729042, 2362.7755363240462, 2394.8084153267696, 2406.915757948472, 2408.9879550602222, 2410.8312418130736, 2375.3942744600104, 2386.809055275574, 2398.3764221302413, 2418.6492958521003, 2428.174420696963, 2360.091364824538, 2380.2026321182425, 2383.2492764779126, 2408.1691816323428, 2417.2869003643877, 2322.814174866007, 2331.475418030938, 2339.82451316152, 2348.0, 2389.1876761901035, 2381.0594815047957, 2389.307100940725, 2414.710234771821, 2417.9274621761374, 2443.1693224303644, 8555.700550480704, 8606.397552171351, 8627.352948528885, 8665.566721663892, 8680.045195028542, 5306.70813105279, 5460.34475862899, 5460.781568737246, 5474.562035037187, 5477.67133971959, 3293.6870997255223, 3329.7502687298547, 3337.3158502506926, 3344.0970937846887, 3363.4618461046116, 1121.6971417717252, 1132.5696235430485, 1135.8977692007759, 1139.0488941733663, 1139.5897476908306, 11501.0, 11819.468123934443, 11829.408529573573, 11832.585859494877, 11850.525978960832, 4610.907781844345, 4638.95361046392, 4838.322634831126, 4872.926906096412, 4881.389826271716, 10232.53953572091, 10272.794544109076, 10283.588656453807, 10291.0, 10310.07209351147, 5404.351477822686, 5438.972805135949, 5440.809571664972, 5466.398696143421, 5500.917486237709, 4275.657947364203, 4862.17343051682, 4943.357363542788, 4966.15575352191, 5058.974705126451, 4112.383142528644, 4129.545749967501, 4138.5790944385135, 4248.830046798155, 4257.91484170321, 1342.0806747378078, 1361.142480237444, 1369.5754316162022, 1374.8556401577691, 1380.0684537936852, 926.7127190570944, 936.9672061477816, 960.6637676813059, 987.2250283527396, 1021.402479549457, 5636.379998200195, 5856.297244330623, 5934.287885453687, 6005.3394126646035, 6046.818595442144, 980.2109302011806, 988.7676396046924, 1006.2101250518455, 1055.9788804223872, 1058.9576416943237, 3972.5232972042963, 4005.819738111792, 4048.291548978917, 4142.647874930664, 4260.403543503912, 9877.753056173653, 10202.234832387601, 10233.283670143019, 10286.382817031003, 10334.224933130045, 10173.08442240202, 10230.335028223142, 10234.897651023395, 10263.178945684327, 10363.222758293008, 7573.394128469819, 7945.801354966172, 7965.8805117923275, 7966.482178658369, 7971.282584567417, 5923.970380148072, 5931.970340148272, 5942.910856337245, 5993.850153746192, 6058.485028772604, 9153.816923661623, 9181.265498759949, 9187.816243675223, 9206.769830754285, 9332.0, 9408.482533460725, 9637.759056023655, 9696.6121355145, 9711.125998660154, 9750.268729845431, 7030.0, 7307.707691692272, 7431.331180193809, 7675.769726908202, 7774.416918731004, 8291.419600627898, 8319.792005199919, 8373.748787536384, 8400.201980811813, 8420.5789710513, 7094.148702155774, 7178.5692858428665, 7490.925090749241, 7515.060617422822, 7539.396848252017, 7307.53673992192, 7484.2141575136, 7497.62511874415, 7559.735409260649, 7764.145943946274, 6730.427913627396, 6857.657117144223, 6859.2454829969665, 6866.485013623898, 6897.379235868796, 4934.259861020875, 4987.975060124676, 5018.498150185098, 5135.768890399866, 5142.871428214325, 4786.497417771084, 5014.974925125351, 5023.1711767557945, 5065.797368105382, 5133.820316289061], "value": 4621.23927915692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.49238865062676, 365.80977891496417, 366.8404244153792, 367.3644594850908, 369.7448760355355, 5684.067417078192, 5840.970795146029, 5895.909256787492, 5949.464548190667, 5964.628135528831, 5811.535077193825, 5816.534677225823, 5827.825165245049, 5856.707164641762, 5869.413058694128, 4608.5852273295395, 4614.492405835373, 4619.145458090264, 4621.428714237159, 4630.0, 4471.709338892978, 4603.9769801151115, 4606.309053641947, 4608.870826647476, 4617.607503362218, 4536.3195520672, 4546.931796023062, 4551.544845515438, 4561.156186105581, 4581.473130589975, 4548.135854187711, 4560.771961401933, 4590.0, 4600.608948239404, 4606.0, 3811.8856434307013, 3946.7434616750106, 4005.4178599453053, 4077.938830917539, 4099.528554216274, 5595.244641973363, 5629.971850140723, 5631.831045068655, 5700.686462244575, 5715.142728590703, 5205.063088644042, 5207.453217412193, 5213.869653258661, 5215.6609820361555, 5232.110541208004, 5836.256959229156, 6033.577649564532, 6067.575269731121, 6075.848103797396, 6084.148219249309, 4378.627816635558, 4384.802683879201, 4391.780410979471, 4395.692301538894, 4409.316555933835, 6173.59871608344, 6309.873802523924, 6328.65192414417, 6378.489720822323, 6387.457066149336, 4451.421315229064, 4464.464264288241, 4469.664775141878, 4480.9103817924115, 4523.592876641118, 4554.79297986034, 4561.475430325489, 4568.931466027946, 4571.428571428572, 4576.26779715244, 5163.922541161885, 5171.870703232374, 5185.818496352609, 5206.140986737221, 5221.295125158131, 5929.466348028698, 6058.454739073504, 6099.950024987506, 6120.66336351496, 6161.44546990773, 1552.945646902353, 1571.5206861907227, 1572.606848287928, 1580.5179420276927, 1583.9208039597975, 972.9075737804898, 991.4546999150439, 1014.6854475112591, 1015.5480811039017, 1017.862588550551, 5225.242339860699, 5255.369355677343, 5260.789568417297, 5263.631545791758, 5292.682439053592, 5438.564914806806, 5468.878879829705, 5477.616566840363, 5507.614466987273, 5512.228288039678, 4913.557779799835, 5188.377394712658, 5240.4759524047295, 5248.661591294195, 5283.833628212491, 2926.7561286453174, 2937.3684657798676, 2975.613170287849, 2989.548570172438, 3002.4145291667915, 5661.433856614306, 5680.488756011979, 5685.403032681592, 5709.314882214161, 5726.599138060379, 5292.338457692788, 5540.529055030287, 5565.914646643865, 5570.721463926788, 5581.09782912883, 5577.358603760538, 5649.576281778801, 5657.886842263214, 5675.716214189274, 5711.257536520226, 5147.944671342291, 5456.554013186429, 5493.0, 5522.66863988162, 5527.39198688152, 5418.674879507243, 5452.028644388897, 5455.781768729206, 5458.9454105458435, 5476.91784623223, 5599.348192283368, 5602.299712535933, 5691.857703557279, 5694.402087780723, 5709.800156994652, 4049.2913740095955, 4062.6140516652054, 4153.127843152851, 4505.549445055468, 4520.570545798144, 6138.785142519991, 6194.721237544411, 6260.843478913063, 6274.0, 6302.0, 6154.846128846814, 6155.599886007574, 6158.32258451561, 6171.9074213887725, 6181.412765787243, 6016.969915150571, 6134.202553667995, 6140.478059365004, 6156.384361563808, 6164.630122192503, 6008.87982240344, 6025.879482410415, 6048.4556389923355, 6066.937241337966, 6080.0, 6194.256689197326, 6194.5973511721595, 6201.844953876009, 6228.283747369111, 6240.344763799917, 5910.379410161871, 5988.640681559121, 6021.698915054318, 6026.233603997502, 6034.185384973148], "value": 4499.333361295203, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.5685353507591, 763.7288762489317, 775.9379249660028, 806.5805780993883, 864.2351518905771, 13523.188608683473, 14093.57719268421, 14099.859001409983, 14158.15051096935, 14312.141271523717, 14677.339519721612, 14734.18961957092, 14795.26023698816, 14845.85154148461, 14892.776608350883, 731.5281643340043, 866.3978534918234, 885.707716453572, 892.8125093730324, 899.4603238057178, 878.0911756332198, 882.7042940614901, 882.9293656507464, 883.2227639677108, 884.6992022712277, 928.7956649537125, 933.2394098809483, 936.7704912296497, 937.0722984245616, 939.3612343606345, 923.4367036107968, 933.2673851026946, 933.5285680731255, 935.3125452792226, 937.3251259093441, 685.1538350137577, 686.7356067913839, 689.1695506914157, 690.2924502385046, 690.6132565763189, 13601.115927464683, 13622.86377136226, 13671.521496747666, 13678.0, 13703.0, 15504.147271900041, 15583.766243506356, 15805.762913556306, 15841.683166336608, 16228.756568651479, 13010.544630937966, 13177.538786142535, 13419.194848309133, 13433.0, 13472.326383680776, 4017.7243799440957, 4069.8168582413864, 4091.754494730326, 4110.588941105895, 4140.68944829139, 86956.0, 86996.0, 87756.12243877607, 88406.55796721039, 93854.5307273466, 12313.319110027409, 12433.440495177738, 12497.50009999608, 12567.18313309632, 12702.872971270353, 23244.0, 23259.7674023261, 23299.18452854142, 23323.41691457693, 23391.532169356517, 8635.13648635144, 9171.81656366869, 9267.953660231791, 9542.666006689733, 9595.184409325146, 4901.681390709592, 5029.245613158056, 5066.974665126724, 5080.517350851663, 5290.285811415487, 3624.7643903146213, 3739.0652336915773, 3764.3036038333, 3773.2453509298252, 3787.4886890270013, 574.9798757043484, 651.6122906870404, 653.5490511547017, 655.1646650520529, 657.1457105762489, 649.9415052645285, 709.925457826931, 718.007529106733, 758.3553979117706, 771.6797529025504, 10111.292209545409, 10308.536115874804, 10398.428086455318, 10453.26827122094, 10534.57861685524, 750.3884334267555, 759.3052357093309, 775.4998026273136, 780.6604127204685, 791.1179035375629, 4922.704637721677, 5167.328247327823, 5191.454897235812, 5248.501392367795, 5272.420033796279, 130167.34916325357, 130644.0, 132849.33575332255, 133803.0, 137585.0, 66948.0, 70950.0, 92304.53847730852, 94948.0, 102033.0, 55520.0, 91195.0, 92270.0, 93246.53376733072, 95086.52456737672, 10216.59133634676, 10250.282480226313, 10471.528781205016, 10644.946775266075, 10723.195760318164, 48493.0, 50197.74901125617, 55221.1716824256, 58360.70819645875, 58364.12453813111, 68569.0, 69287.30712692809, 78061.0, 78845.0, 79346.6032669833, 13572.796408054084, 13747.862521375058, 13848.861511385161, 14146.858531414555, 14480.203588802717, 15789.763153552476, 15996.360145594512, 16224.35102595883, 16489.34042638329, 16729.749053764448, 14809.703805924037, 15123.31945062497, 15317.846821531642, 15363.308651110503, 16195.43315983935, 14135.0, 14299.0, 14309.928450357682, 14399.78400323975, 14776.113433194043, 14705.779727338264, 14857.182854943081, 14966.04031566896, 15076.924615376853, 15167.089974601558, 12272.386380680751, 13025.869741302844, 13079.084464087804, 13134.40895159701, 13304.933475332562, 12566.434510447234, 12794.232346059267, 12969.740605187655, 13062.150960187557, 13153.802692959805], "value": 8039.233858937627, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1491.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 104.0, 113.0, 111.0, 111.0, 109.0, 111.0, 111.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 119.0, 152.0, 175.0, 117.0, 138.0, 146.0, 119.0, 175.0, 119.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 163.0, 163.0, 162.0, 162.0, 162.0, 162.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 181.0, 77.0, 73.0, 75.0, 76.0, 169.0, 75.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 142.0, 84.0, 84.0, 84.0, 140.0, 83.0, 84.0, 146.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 50.0, 50.0, 52.0, 50.0, 50.0, 53.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 62.0, 61.0, 60.0, 60.0, 60.0, 63.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 78.0, 72.0, 73.0, 72.0, 72.0, 77.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 124.0, 120.0, 118.0, 120.0, 118.0, 131.0, 117.0, 156.0, 117.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 147.0, 150.0, 151.0, 152.0, 156.0, 150.0, 150.0, 151.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 63.0, 62.0, 61.0, 64.0, 60.0, 59.0], "value": 61.8, "unit": "score"}]}]} 15:23:27 INFO - Return code: 0 15:23:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:23:27 ERROR - # TBPL SUCCESS # 15:23:27 INFO - Running post-action listener: _resource_record_post_action 15:23:27 INFO - [mozharness: 2016-09-29 22:23:27.824417Z] Finished run-tests step (success) 15:23:27 INFO - Running post-run listener: _resource_record_post_run 15:23:27 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 286482432; Read time: 68; Write time: 390436 15:23:27 INFO - TinderboxPrint: CPU usage
13.3% 15:23:27 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 68 15:23:27 INFO - TinderboxPrint: I/O write bytes / time
286,482,432 / 390,436 15:23:27 INFO - TinderboxPrint: CPU idle
8,214.7 (86.7%) 15:23:27 INFO - TinderboxPrint: CPU user
1,198.8 (12.7%) 15:23:27 INFO - TinderboxPrint: Swap in / out
0 / 0 15:23:27 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 71335936; Read time: 0; Write time: 197120 15:23:27 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 215146496; Read time: 68; Write time: 193316 15:23:28 INFO - Running post-run listener: _upload_blobber_files 15:23:28 INFO - Blob upload gear active. 15:23:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:23:28 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 15:23:28 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:23:28 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:23:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:23:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:23:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:23:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:29 INFO - (blobuploader) - INFO - Done attempting. 15:23:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:23:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:23:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:34 INFO - (blobuploader) - INFO - Done attempting. 15:23:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:23:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:23:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:35 INFO - (blobuploader) - INFO - Done attempting. 15:23:35 INFO - (blobuploader) - INFO - Iteration through files over. 15:23:35 INFO - Return code: 0 15:23:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:23:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:23:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c24559721e78854d8148e78c355bb131e72db8aa250fc5d288c1b4c637d42d8379aee21c16ada06f4064b02ca7cd24539c111a59442c65d314c9b62726be32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8587c8a03862356b0673c04062f94291fce850ee0f70d57b48a8ce7517ebe9c1258b67fa93f6ec321a165d93c18ae7867919f0912c377260ba5c9f93e0b46124", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fff114d210bcede070eebdad50bd5a027f6107b79913710a21c81de0e3ad4a13df9d38b27fab319b61f590f973e580317c017038e5460538ae33db6efd93478c"} 15:23:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:23:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:23:35 INFO - Contents: 15:23:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c24559721e78854d8148e78c355bb131e72db8aa250fc5d288c1b4c637d42d8379aee21c16ada06f4064b02ca7cd24539c111a59442c65d314c9b62726be32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8587c8a03862356b0673c04062f94291fce850ee0f70d57b48a8ce7517ebe9c1258b67fa93f6ec321a165d93c18ae7867919f0912c377260ba5c9f93e0b46124", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fff114d210bcede070eebdad50bd5a027f6107b79913710a21c81de0e3ad4a13df9d38b27fab319b61f590f973e580317c017038e5460538ae33db6efd93478c"} 15:23:35 INFO - Running post-run listener: copy_logs_to_upload_dir 15:23:35 INFO - Copying logs to upload dir... 15:23:35 INFO - mkdir: /builds/slave/test/build/upload/logs 15:23:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.924332 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-29 15:23:35.368039) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 15:23:35.371153) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367 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-Beta/sha512/1c24559721e78854d8148e78c355bb131e72db8aa250fc5d288c1b4c637d42d8379aee21c16ada06f4064b02ca7cd24539c111a59442c65d314c9b62726be32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8587c8a03862356b0673c04062f94291fce850ee0f70d57b48a8ce7517ebe9c1258b67fa93f6ec321a165d93c18ae7867919f0912c377260ba5c9f93e0b46124", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fff114d210bcede070eebdad50bd5a027f6107b79913710a21c81de0e3ad4a13df9d38b27fab319b61f590f973e580317c017038e5460538ae33db6efd93478c"} build_url:https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/cu731cJtRw24cDyfF96LXg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c24559721e78854d8148e78c355bb131e72db8aa250fc5d288c1b4c637d42d8379aee21c16ada06f4064b02ca7cd24539c111a59442c65d314c9b62726be32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8587c8a03862356b0673c04062f94291fce850ee0f70d57b48a8ce7517ebe9c1258b67fa93f6ec321a165d93c18ae7867919f0912c377260ba5c9f93e0b46124", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fff114d210bcede070eebdad50bd5a027f6107b79913710a21c81de0e3ad4a13df9d38b27fab319b61f590f973e580317c017038e5460538ae33db6efd93478c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 15:23:35.396551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:23:35.396910) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1475185963.280998-208365367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 15:23:35.483426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 15:23:35.484216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 15:23:35.484877) ========= ========= Total master_lag: 0.20 =========