builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1472867146.59 results: success (0) buildid: 20160902160050 builduid: b954e943d60047298c8c718863c8a0b0 revision: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.594506) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.594848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.595128) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.617399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.617672) ========= 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=32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 18:45:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-09-02 18:45:47 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076178 ========= master_lag: 0.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.882685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.882954) ========= 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=32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021060 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.918471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:46.918771) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 18:45:47,494 truncating revision to first 12 chars 2016-09-02 18:45:47,494 Setting DEBUG logging. 2016-09-02 18:45:47,494 attempt 1/10 2016-09-02 18:45:47,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d35ac86c5271?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 18:45:47,806 unpacking tar archive at: mozilla-aurora-d35ac86c5271/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:47.562298) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:47.562878) ========= script_repo_revision: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:47.563625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:47.564253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 18:45:47.575605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-02 18:45:47.575887) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:45:48 INFO - MultiFileLogger online at 20160902 18:45:48 in /builds/slave/test 18:45:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:45:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:45:48 INFO - {'append_to_log': False, 18:45:48 INFO - 'base_work_dir': '/builds/slave/test', 18:45:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:45:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:45:48 INFO - 'branch': 'Mozilla-Aurora', 18:45:48 INFO - 'buildbot_json_path': 'buildprops.json', 18:45:48 INFO - 'config_files': ('talos/linux_config.py',), 18:45:48 INFO - 'default_actions': ('clobber', 18:45:48 INFO - 'read-buildbot-config', 18:45:48 INFO - 'download-and-extract', 18:45:48 INFO - 'populate-webroot', 18:45:48 INFO - 'create-virtualenv', 18:45:48 INFO - 'install', 18:45:48 INFO - 'run-tests'), 18:45:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:45:48 INFO - 'download_minidump_stackwalk': True, 18:45:48 INFO - 'download_symbols': 'ondemand', 18:45:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:45:48 INFO - 'tooltool.py': '/tools/tooltool.py', 18:45:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:45:48 INFO - '/tools/misc-python/virtualenv.py')}, 18:45:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:45:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:45:48 INFO - 'installer_path': 'installer.exe', 18:45:48 INFO - 'log_level': 'info', 18:45:48 INFO - 'log_name': 'talos', 18:45:48 INFO - 'log_to_console': True, 18:45:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:45:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:45:48 INFO - 'opt_config_files': (), 18:45:48 INFO - 'pip_index': False, 18:45:48 INFO - 'sps_profile': False, 18:45:48 INFO - 'sps_profile_interval': 0, 18:45:48 INFO - 'suite': 'dromaeojs-e10s', 18:45:48 INFO - 'system_bits': '32', 18:45:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:45:48 INFO - 'title': 'talos-linux64-ix-008', 18:45:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:45:48 INFO - 'use_talos_json': True, 18:45:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:45:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:45:48 INFO - 'work_dir': 'build'} 18:45:48 INFO - [mozharness: 2016-09-03 01:45:48.242220Z] Running clobber step. 18:45:48 INFO - Running pre-action listener: _resource_record_pre_action 18:45:48 INFO - Running main action method: clobber 18:45:48 INFO - rmtree: /builds/slave/test/build 18:45:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:45:48 INFO - Running post-action listener: _resource_record_post_action 18:45:48 INFO - [mozharness: 2016-09-03 01:45:48.690605Z] Finished clobber step (success) 18:45:48 INFO - [mozharness: 2016-09-03 01:45:48.690706Z] Running read-buildbot-config step. 18:45:48 INFO - Running pre-action listener: _resource_record_pre_action 18:45:48 INFO - Running main action method: read_buildbot_config 18:45:48 INFO - Using buildbot properties: 18:45:48 INFO - { 18:45:48 INFO - "project": "", 18:45:48 INFO - "product": "firefox", 18:45:48 INFO - "script_repo_revision": "production", 18:45:48 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:45:48 INFO - "repository": "", 18:45:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:45:48 INFO - "buildid": "20160902160050", 18:45:48 INFO - "pgo_build": "True", 18:45:48 INFO - "basedir": "/builds/slave/test", 18:45:48 INFO - "buildnumber": 540, 18:45:48 INFO - "slavename": "talos-linux64-ix-008", 18:45:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:45:48 INFO - "platform": "ubuntu64_hw", 18:45:48 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:45:48 INFO - "branch": "mozilla-aurora", 18:45:48 INFO - "repo_path": "releases/mozilla-aurora", 18:45:48 INFO - "revision": "d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd", 18:45:48 INFO - "stage_platform": "linux64-pgo", 18:45:48 INFO - "builduid": "b954e943d60047298c8c718863c8a0b0", 18:45:48 INFO - "slavebuilddir": "test" 18:45:48 INFO - } 18:45:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 18:45:48 INFO - Running post-action listener: _resource_record_post_action 18:45:48 INFO - [mozharness: 2016-09-03 01:45:48.693142Z] Finished read-buildbot-config step (success) 18:45:48 INFO - [mozharness: 2016-09-03 01:45:48.693230Z] Running download-and-extract step. 18:45:48 INFO - Running pre-action listener: _resource_record_pre_action 18:45:48 INFO - Running main action method: download_and_extract 18:45:48 INFO - mkdir: /builds/slave/test/build/tests 18:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:48 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:45:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:45:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 18:45:48 INFO - retry: Failed, sleeping 30 seconds before retrying 18:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 18:46:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:46:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 18:46:18 INFO - retry: Failed, sleeping 60 seconds before retrying 18:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 18:47:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:47:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 18:47:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 18:47:18 INFO - Caught exception: HTTP Error 404: Not Found 18:47:18 INFO - Caught exception: HTTP Error 404: Not Found 18:47:18 INFO - Caught exception: HTTP Error 404: Not Found 18:47:18 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:47:18 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:47:19 INFO - Downloaded 1361 bytes. 18:47:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 18:47:19 INFO - Using the following test package requirements: 18:47:19 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 18:47:19 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:19 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:47:19 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'jsshell-linux-x86_64.zip'], 18:47:19 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:19 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 18:47:19 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:47:19 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:47:19 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:19 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:19 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:19 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:47:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:47:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:47:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:47:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 18:47:19 INFO - retry: Failed, sleeping 30 seconds before retrying 18:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 18:47:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:47:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 18:47:49 INFO - retry: Failed, sleeping 60 seconds before retrying 18:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 18:48:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:48:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 18:48:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 18:48:49 INFO - Caught exception: HTTP Error 404: Not Found 18:48:49 INFO - Caught exception: HTTP Error 404: Not Found 18:48:49 INFO - Caught exception: HTTP Error 404: Not Found 18:48:49 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:48:49 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:48:50 INFO - Downloaded 21839364 bytes. 18:48:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:48:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:48:51 INFO - Return code: 0 18:48:51 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:51 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:48:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:48:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 18:48:51 INFO - retry: Failed, sleeping 30 seconds before retrying 18:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 18:49:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:49:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 18:49:21 INFO - retry: Failed, sleeping 60 seconds before retrying 18:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 18:50:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:50:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 18:50:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 18:50:21 INFO - Caught exception: HTTP Error 404: Not Found 18:50:21 INFO - Caught exception: HTTP Error 404: Not Found 18:50:21 INFO - Caught exception: HTTP Error 404: Not Found 18:50:21 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:50:21 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 18:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:50:22 INFO - Downloaded 21839364 bytes. 18:50:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:50:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:50:23 INFO - Return code: 0 18:50: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')]} 18:50:23 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:50:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:50:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:50:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:50:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:50:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 18:50:23 INFO - retry: Failed, sleeping 30 seconds before retrying 18:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 18:50:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:50:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 18:50:53 INFO - retry: Failed, sleeping 60 seconds before retrying 18:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 18:51:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:51:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 18:51:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 18:51:53 INFO - Caught exception: HTTP Error 404: Not Found 18:51:53 INFO - Caught exception: HTTP Error 404: Not Found 18:51:53 INFO - Caught exception: HTTP Error 404: Not Found 18:51:53 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:51:53 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 18:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:51:54 INFO - Downloaded 14413740 bytes. 18:51:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:51:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:51:54 INFO - Return code: 0 18:51: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')]} 18:51:54 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:51:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:51:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 18:51:54 INFO - retry: Failed, sleeping 30 seconds before retrying 18:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 18:52:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:52:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 18:52:24 INFO - retry: Failed, sleeping 60 seconds before retrying 18:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 18:53:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:53:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 18:53:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 18:53:25 INFO - Caught exception: HTTP Error 404: Not Found 18:53:25 INFO - Caught exception: HTTP Error 404: Not Found 18:53:25 INFO - Caught exception: HTTP Error 404: Not Found 18:53:25 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:53:25 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:53:26 INFO - Downloaded 63899078 bytes. 18:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:53:26 INFO - mkdir: /builds/slave/test/properties 18:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 18:53:26 INFO - Contents: 18:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 18:53:26 INFO - Running post-action listener: _resource_record_post_action 18:53:26 INFO - Running post-action listener: set_extra_try_arguments 18:53:26 INFO - [mozharness: 2016-09-03 01:53:26.952877Z] Finished download-and-extract step (success) 18:53:26 INFO - [mozharness: 2016-09-03 01:53:26.953108Z] Running populate-webroot step. 18:53:26 INFO - Running pre-action listener: _resource_record_pre_action 18:53:26 INFO - Running main action method: populate_webroot 18:53:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:26 INFO - '--tppagecycles', 18:53:26 INFO - '7'], 18:53:26 INFO - 'tests': ['tsvgm']}}, 18:53:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:53:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:53:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:53:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['damp', 'tps']}, 18:53:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['damp', 'tps']}, 18:53:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['dromaeo_dom']}, 18:53:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:53:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['basic_compositor_video']}, 18:53:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:53:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tsvgx', 18:53:26 INFO - 'tsvgr_opacity', 18:53:26 INFO - 'tart', 18:53:26 INFO - 'tscrollx', 18:53:26 INFO - 'cart']}, 18:53:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:53:26 INFO - 'tsvgr_opacity', 18:53:26 INFO - 'tart', 18:53:26 INFO - 'tscrollx', 18:53:26 INFO - 'cart']}, 18:53:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s'], 18:53:26 INFO - 'tests': ['tp5o']}, 18:53:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['tp5o']}, 18:53:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--disable-e10s', 18:53:26 INFO - '--xperf_path', 18:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:26 INFO - 'tests': ['tp5n']}, 18:53:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--xperf_path', 18:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:26 INFO - 'tests': ['tp5n']}}, 18:53:26 INFO - 'talos.zip': {'path': '', 18:53:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:26 INFO - Running post-action listener: _resource_record_post_action 18:53:26 INFO - [mozharness: 2016-09-03 01:53:26.974182Z] Finished populate-webroot step (success) 18:53:26 INFO - [mozharness: 2016-09-03 01:53:26.974272Z] Running create-virtualenv step. 18:53:26 INFO - Running pre-action listener: _resource_record_pre_action 18:53:26 INFO - Running main action method: create_virtualenv 18:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 18:53:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:53:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:53:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:27 INFO - Using real prefix '/usr' 18:53:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:53:27 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:29 INFO - Installing pip.................done. 18:53:29 INFO - Return code: 0 18:53:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:53: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')]} 18:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:53:29 INFO - Using env: {'DISPLAY': ':0', 18:53:29 INFO - 'HOME': '/home/cltbld', 18:53:29 INFO - 'LANG': 'en_US.UTF-8', 18:53:29 INFO - 'LANGUAGE': 'en_US:en', 18:53:29 INFO - 'LOGNAME': 'cltbld', 18:53:29 INFO - 'MAIL': '/var/mail/cltbld', 18:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:29 INFO - 'MOZ_NO_REMOTE': '1', 18:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:29 INFO - 'NO_EM_RESTART': '1', 18:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:29 INFO - 'PWD': '/builds/slave/test', 18:53:29 INFO - 'SHELL': '/bin/bash', 18:53:29 INFO - 'SHLVL': '1', 18:53:29 INFO - 'TERM': 'linux', 18:53:29 INFO - 'TMOUT': '86400', 18:53:29 INFO - 'USER': 'cltbld', 18:53:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:29 INFO - '_': '/tools/buildbot/bin/python'} 18:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:53:29 INFO - Cleaning up... 18:53:29 INFO - Return code: 0 18:53:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:53: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')]} 18:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:53:29 INFO - Using env: {'DISPLAY': ':0', 18:53:29 INFO - 'HOME': '/home/cltbld', 18:53:29 INFO - 'LANG': 'en_US.UTF-8', 18:53:29 INFO - 'LANGUAGE': 'en_US:en', 18:53:29 INFO - 'LOGNAME': 'cltbld', 18:53:29 INFO - 'MAIL': '/var/mail/cltbld', 18:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:29 INFO - 'MOZ_NO_REMOTE': '1', 18:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:29 INFO - 'NO_EM_RESTART': '1', 18:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:29 INFO - 'PWD': '/builds/slave/test', 18:53:29 INFO - 'SHELL': '/bin/bash', 18:53:29 INFO - 'SHLVL': '1', 18:53:29 INFO - 'TERM': 'linux', 18:53:29 INFO - 'TMOUT': '86400', 18:53:29 INFO - 'USER': 'cltbld', 18:53:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:29 INFO - '_': '/tools/buildbot/bin/python'} 18:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:29 INFO - Downloading/unpacking psutil>=3.1.1 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:31 INFO - Installing collected packages: psutil 18:53:31 INFO - Running setup.py install for psutil 18:53:32 INFO - building 'psutil._psutil_linux' extension 18:53:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:53:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:53:32 INFO - building 'psutil._psutil_posix' extension 18:53:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:53:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:53:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:32 INFO - Successfully installed psutil 18:53:32 INFO - Cleaning up... 18:53:32 INFO - Return code: 0 18:53:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:53: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')]} 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:53:32 INFO - Using env: {'DISPLAY': ':0', 18:53:32 INFO - 'HOME': '/home/cltbld', 18:53:32 INFO - 'LANG': 'en_US.UTF-8', 18:53:32 INFO - 'LANGUAGE': 'en_US:en', 18:53:32 INFO - 'LOGNAME': 'cltbld', 18:53:32 INFO - 'MAIL': '/var/mail/cltbld', 18:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:32 INFO - 'MOZ_NO_REMOTE': '1', 18:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:32 INFO - 'NO_EM_RESTART': '1', 18:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:32 INFO - 'PWD': '/builds/slave/test', 18:53:32 INFO - 'SHELL': '/bin/bash', 18:53:32 INFO - 'SHLVL': '1', 18:53:32 INFO - 'TERM': 'linux', 18:53:32 INFO - 'TMOUT': '86400', 18:53:32 INFO - 'USER': 'cltbld', 18:53:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:32 INFO - '_': '/tools/buildbot/bin/python'} 18:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:53:34 INFO - Installing collected packages: mozsystemmonitor 18:53:34 INFO - Running setup.py install for mozsystemmonitor 18:53:34 INFO - Successfully installed mozsystemmonitor 18:53:34 INFO - Cleaning up... 18:53:34 INFO - Return code: 0 18:53:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:53:34 INFO - Using env: {'DISPLAY': ':0', 18:53:34 INFO - 'HOME': '/home/cltbld', 18:53:34 INFO - 'LANG': 'en_US.UTF-8', 18:53:34 INFO - 'LANGUAGE': 'en_US:en', 18:53:34 INFO - 'LOGNAME': 'cltbld', 18:53:34 INFO - 'MAIL': '/var/mail/cltbld', 18:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:34 INFO - 'MOZ_NO_REMOTE': '1', 18:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:34 INFO - 'NO_EM_RESTART': '1', 18:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:34 INFO - 'PWD': '/builds/slave/test', 18:53:34 INFO - 'SHELL': '/bin/bash', 18:53:34 INFO - 'SHLVL': '1', 18:53:34 INFO - 'TERM': 'linux', 18:53:34 INFO - 'TMOUT': '86400', 18:53:34 INFO - 'USER': 'cltbld', 18:53:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:34 INFO - '_': '/tools/buildbot/bin/python'} 18:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:34 INFO - Downloading/unpacking jsonschema==2.5.1 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:53:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:37 INFO - Downloading functools32-3.2.3-2.tar.gz 18:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:53:37 INFO - warning: no files found matching '*.txt' 18:53:37 INFO - no previously-included directories found matching 'build' 18:53:37 INFO - no previously-included directories found matching 'dist' 18:53:37 INFO - no previously-included directories found matching '.git*' 18:53:37 INFO - Installing collected packages: jsonschema, functools32 18:53:37 INFO - Running setup.py install for functools32 18:53:37 INFO - warning: no files found matching '*.txt' 18:53:37 INFO - no previously-included directories found matching 'build' 18:53:37 INFO - no previously-included directories found matching 'dist' 18:53:37 INFO - no previously-included directories found matching '.git*' 18:53:37 INFO - Successfully installed jsonschema functools32 18:53:37 INFO - Cleaning up... 18:53:37 INFO - Return code: 0 18:53:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:53:37 INFO - Using env: {'DISPLAY': ':0', 18:53:37 INFO - 'HOME': '/home/cltbld', 18:53:37 INFO - 'LANG': 'en_US.UTF-8', 18:53:37 INFO - 'LANGUAGE': 'en_US:en', 18:53:37 INFO - 'LOGNAME': 'cltbld', 18:53:37 INFO - 'MAIL': '/var/mail/cltbld', 18:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:37 INFO - 'MOZ_NO_REMOTE': '1', 18:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:37 INFO - 'NO_EM_RESTART': '1', 18:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:37 INFO - 'PWD': '/builds/slave/test', 18:53:37 INFO - 'SHELL': '/bin/bash', 18:53:37 INFO - 'SHLVL': '1', 18:53:37 INFO - 'TERM': 'linux', 18:53:37 INFO - 'TMOUT': '86400', 18:53:37 INFO - 'USER': 'cltbld', 18:53:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:37 INFO - '_': '/tools/buildbot/bin/python'} 18:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:53:37 INFO - Cleaning up... 18:53:37 INFO - Return code: 0 18:53:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:53:37 INFO - Using env: {'DISPLAY': ':0', 18:53:37 INFO - 'HOME': '/home/cltbld', 18:53:37 INFO - 'LANG': 'en_US.UTF-8', 18:53:37 INFO - 'LANGUAGE': 'en_US:en', 18:53:37 INFO - 'LOGNAME': 'cltbld', 18:53:37 INFO - 'MAIL': '/var/mail/cltbld', 18:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:37 INFO - 'MOZ_NO_REMOTE': '1', 18:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:37 INFO - 'NO_EM_RESTART': '1', 18:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:37 INFO - 'PWD': '/builds/slave/test', 18:53:37 INFO - 'SHELL': '/bin/bash', 18:53:37 INFO - 'SHLVL': '1', 18:53:37 INFO - 'TERM': 'linux', 18:53:37 INFO - 'TMOUT': '86400', 18:53:37 INFO - 'USER': 'cltbld', 18:53:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:37 INFO - '_': '/tools/buildbot/bin/python'} 18:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:37 INFO - Downloading/unpacking blobuploader==1.2.4 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:53:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:40 INFO - Downloading docopt-0.6.1.tar.gz 18:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:40 INFO - Running setup.py install for blobuploader 18:53:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:53:40 INFO - Running setup.py install for requests 18:53:40 INFO - Running setup.py install for docopt 18:53:40 INFO - Successfully installed blobuploader requests docopt 18:53:40 INFO - Cleaning up... 18:53:40 INFO - Return code: 0 18:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:41 INFO - Using env: {'DISPLAY': ':0', 18:53:41 INFO - 'HOME': '/home/cltbld', 18:53:41 INFO - 'LANG': 'en_US.UTF-8', 18:53:41 INFO - 'LANGUAGE': 'en_US:en', 18:53:41 INFO - 'LOGNAME': 'cltbld', 18:53:41 INFO - 'MAIL': '/var/mail/cltbld', 18:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:41 INFO - 'MOZ_NO_REMOTE': '1', 18:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:41 INFO - 'NO_EM_RESTART': '1', 18:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:41 INFO - 'PWD': '/builds/slave/test', 18:53:41 INFO - 'SHELL': '/bin/bash', 18:53:41 INFO - 'SHLVL': '1', 18:53:41 INFO - 'TERM': 'linux', 18:53:41 INFO - 'TMOUT': '86400', 18:53:41 INFO - 'USER': 'cltbld', 18:53:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:41 INFO - '_': '/tools/buildbot/bin/python'} 18:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:41 INFO - Running setup.py (path:/tmp/pip-rmlv7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:41 INFO - Running setup.py (path:/tmp/pip-KnQ7G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:41 INFO - Running setup.py (path:/tmp/pip-hBEOZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:41 INFO - Running setup.py (path:/tmp/pip-lmyV35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:41 INFO - Running setup.py (path:/tmp/pip-D3DRjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:41 INFO - Running setup.py (path:/tmp/pip-KoGXbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:41 INFO - Running setup.py (path:/tmp/pip-IxY_RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:41 INFO - Running setup.py (path:/tmp/pip-7qoCcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:41 INFO - Running setup.py (path:/tmp/pip-XHxvik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:41 INFO - Running setup.py (path:/tmp/pip-727ZlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:41 INFO - Running setup.py (path:/tmp/pip-sHpwKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:42 INFO - Running setup.py (path:/tmp/pip-b0ZN40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:42 INFO - Running setup.py (path:/tmp/pip-65a6BP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:42 INFO - Running setup.py (path:/tmp/pip-GD0m0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:42 INFO - Running setup.py (path:/tmp/pip-jSZgXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:42 INFO - Running setup.py (path:/tmp/pip-3D0AVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:42 INFO - Running setup.py (path:/tmp/pip-8ike_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:42 INFO - Running setup.py install for manifestparser 18:53:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:53:42 INFO - Running setup.py install for mozcrash 18:53:42 INFO - Running setup.py install for mozdebug 18:53:42 INFO - Running setup.py install for mozdevice 18:53:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:53:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:53:42 INFO - Running setup.py install for mozfile 18:53:42 INFO - Running setup.py install for mozhttpd 18:53:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozinfo 18:53:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozInstall 18:53:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozleak 18:53:43 INFO - Running setup.py install for mozlog 18:53:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for moznetwork 18:53:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozprocess 18:53:43 INFO - Running setup.py install for mozprofile 18:53:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozrunner 18:53:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:53:43 INFO - Running setup.py install for mozscreenshot 18:53:44 INFO - Running setup.py install for moztest 18:53:44 INFO - Running setup.py install for mozversion 18:53:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:53:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:53:44 INFO - Cleaning up... 18:53:44 INFO - Return code: 0 18:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:44 INFO - Using env: {'DISPLAY': ':0', 18:53:44 INFO - 'HOME': '/home/cltbld', 18:53:44 INFO - 'LANG': 'en_US.UTF-8', 18:53:44 INFO - 'LANGUAGE': 'en_US:en', 18:53:44 INFO - 'LOGNAME': 'cltbld', 18:53:44 INFO - 'MAIL': '/var/mail/cltbld', 18:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:44 INFO - 'MOZ_NO_REMOTE': '1', 18:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:44 INFO - 'NO_EM_RESTART': '1', 18:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:44 INFO - 'PWD': '/builds/slave/test', 18:53:44 INFO - 'SHELL': '/bin/bash', 18:53:44 INFO - 'SHLVL': '1', 18:53:44 INFO - 'TERM': 'linux', 18:53:44 INFO - 'TMOUT': '86400', 18:53:44 INFO - 'USER': 'cltbld', 18:53:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:44 INFO - '_': '/tools/buildbot/bin/python'} 18:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:44 INFO - Running setup.py (path:/tmp/pip-3uFcNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:44 INFO - Running setup.py (path:/tmp/pip-nV16eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:44 INFO - Running setup.py (path:/tmp/pip-v2oICt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:44 INFO - Running setup.py (path:/tmp/pip-PH2cbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:44 INFO - Running setup.py (path:/tmp/pip-Scn5P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:44 INFO - Running setup.py (path:/tmp/pip-l37uGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:44 INFO - Running setup.py (path:/tmp/pip-IL_6Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:44 INFO - Running setup.py (path:/tmp/pip-IPhHBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:45 INFO - Running setup.py (path:/tmp/pip-knqp7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:45 INFO - Running setup.py (path:/tmp/pip-2uXznV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:45 INFO - Running setup.py (path:/tmp/pip-cr_jEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:45 INFO - Running setup.py (path:/tmp/pip-qIWkdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:45 INFO - Running setup.py (path:/tmp/pip-KKRtLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:45 INFO - Running setup.py (path:/tmp/pip-OxE4Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:45 INFO - Running setup.py (path:/tmp/pip-d1JiuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:45 INFO - Running setup.py (path:/tmp/pip-M19sch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:45 INFO - Running setup.py (path:/tmp/pip-Tok6gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:47 INFO - Downloading blessings-1.6.tar.gz 18:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:53:47 INFO - Installing collected packages: blessings 18:53:47 INFO - Running setup.py install for blessings 18:53:47 INFO - Successfully installed blessings 18:53:47 INFO - Cleaning up... 18:53:47 INFO - Return code: 0 18:53:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:53:47 INFO - Reading from file tmpfile_stdout 18:53:47 INFO - Current package versions: 18:53:47 INFO - argparse == 1.2.1 18:53:47 INFO - blessings == 1.6 18:53:47 INFO - blobuploader == 1.2.4 18:53:47 INFO - docopt == 0.6.1 18:53:47 INFO - functools32 == 3.2.3-2 18:53:47 INFO - jsonschema == 2.5.1 18:53:47 INFO - manifestparser == 1.1 18:53:47 INFO - mozInstall == 1.12 18:53:47 INFO - mozcrash == 0.17 18:53:47 INFO - mozdebug == 0.1 18:53:47 INFO - mozdevice == 0.48 18:53:47 INFO - mozfile == 1.2 18:53:47 INFO - mozhttpd == 0.7 18:53:47 INFO - mozinfo == 0.9 18:53:47 INFO - mozleak == 0.1 18:53:47 INFO - mozlog == 3.3 18:53:47 INFO - moznetwork == 0.27 18:53:47 INFO - mozprocess == 0.23 18:53:47 INFO - mozprofile == 0.28 18:53:47 INFO - mozrunner == 6.12 18:53:47 INFO - mozscreenshot == 0.1 18:53:47 INFO - mozsystemmonitor == 0.3 18:53:47 INFO - moztest == 0.7 18:53:47 INFO - mozversion == 1.4 18:53:47 INFO - psutil == 3.1.1 18:53:47 INFO - requests == 1.2.3 18:53:47 INFO - wsgiref == 0.1.2 18:53:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1384030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b3400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, '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': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', '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 18:53:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Running post-action listener: _resource_record_post_action 18:53:48 INFO - Running post-action listener: _start_resource_monitoring 18:53:48 INFO - Starting resource monitoring. 18:53:48 INFO - [mozharness: 2016-09-03 01:53:48.462518Z] Finished create-virtualenv step (success) 18:53:48 INFO - [mozharness: 2016-09-03 01:53:48.462988Z] Running install step. 18:53:48 INFO - Running pre-action listener: _resource_record_pre_action 18:53:48 INFO - Running main action method: install 18:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:53:48 INFO - Reading from file tmpfile_stdout 18:53:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:53:48 INFO - Reading from file tmpfile_stdout 18:53:48 INFO - Output received: 18:53:48 INFO - Usage: mozinstall [options] installer 18:53:48 INFO - Options: 18:53:48 INFO - -h, --help show this help message and exit 18:53:48 INFO - -d DEST, --destination=DEST 18:53:48 INFO - Directory to install application into. [default: 18:53:48 INFO - "/builds/slave/test"] 18:53:48 INFO - --app=APP Application being installed. [default: firefox] 18:53:48 INFO - mkdir: /builds/slave/test/build/application 18:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:54:05 INFO - Reading from file tmpfile_stdout 18:54:05 INFO - Output received: 18:54:05 INFO - /builds/slave/test/build/application/firefox/firefox 18:54:05 INFO - Running post-action listener: _resource_record_post_action 18:54:05 INFO - [mozharness: 2016-09-03 01:54:05.828309Z] Finished install step (success) 18:54:05 INFO - [mozharness: 2016-09-03 01:54:05.828587Z] Running run-tests step. 18:54:05 INFO - Running pre-action listener: _resource_record_pre_action 18:54:05 INFO - Running main action method: run_tests 18:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:54:05 INFO - Python 2.7.3 18:54:05 INFO - Return code: 0 18:54:05 INFO - grabbing minidump binary from tooltool 18:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1642570>, '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 0x1643470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1643900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:54:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:54:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:54:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:54:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:05 INFO - Return code: 0 18:54:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:54:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:54:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:54:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:54:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 18:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 18:54:05 INFO - Using env: {'DISPLAY': ':0', 18:54:05 INFO - 'HOME': '/home/cltbld', 18:54:05 INFO - 'LANG': 'en_US.UTF-8', 18:54:05 INFO - 'LANGUAGE': 'en_US:en', 18:54:05 INFO - 'LOGNAME': 'cltbld', 18:54:05 INFO - 'MAIL': '/var/mail/cltbld', 18:54:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:54:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:05 INFO - 'MOZ_NO_REMOTE': '1', 18:54:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:05 INFO - 'NO_EM_RESTART': '1', 18:54:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:05 INFO - 'PWD': '/builds/slave/test', 18:54:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:54:05 INFO - 'SHELL': '/bin/bash', 18:54:05 INFO - 'SHLVL': '1', 18:54:05 INFO - 'TERM': 'linux', 18:54:05 INFO - 'TMOUT': '86400', 18:54:05 INFO - 'USER': 'cltbld', 18:54:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166', 18:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:05 INFO - '_': '/tools/buildbot/bin/python'} 18:54:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 18:54:06 INFO - mozversion application_buildid: 20160902160050 18:54:06 INFO - mozversion application_changeset: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd 18:54:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:54:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:06 INFO - mozversion application_name: Firefox 18:54:06 INFO - mozversion application_remotingname: firefox-dev 18:54:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:54:06 INFO - mozversion application_vendor: Mozilla 18:54:06 INFO - mozversion application_version: 50.0a2 18:54:06 INFO - mozversion platform_buildid: 20160902160050 18:54:06 INFO - mozversion platform_changeset: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd 18:54:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:54:06 INFO - mozversion platform_version: 50.0a2 18:54:06 INFO - using testdate: 1472867646 18:54:06 INFO - actual date: 1472867646 18:54:06 INFO - starting webserver on 'localhost:51567' 18:54:06 INFO - SUITE-START | Running 2 tests 18:54:06 INFO - TEST-START | dromaeo_css 18:54:06 INFO - operating with platform_type : linux_ 18:54:06 INFO - Initialising browser for dromaeo_css test... 18:54:06 INFO - TEST-INFO | started process 7282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVYXzr/profile http://localhost:51567/getInfo.html) 18:54:10 INFO - PROCESS | 7282 | __metrics Screen width/height:1600/1200 18:54:10 INFO - PROCESS | 7282 | colorDepth:24 18:54:10 INFO - PROCESS | 7282 | Browser inner width/height: 1024/697 18:54:10 INFO - PROCESS | 7282 | __metrics 18:54:11 ERROR - PROCESS | 7282 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:54:12 INFO - TEST-INFO | 7282: exit 0 18:54:12 INFO - Browser initialized. 18:54:12 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:12 INFO - TEST-INFO | started process 7407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVYXzr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:23 INFO - PROCESS | 7407 | RSS: Main: 152625152 18:54:23 INFO - PROCESS | 7407 | 18:55:13 INFO - PROCESS | 7407 | 1472867713526 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] 18:57:22 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51567/tests/dromaeo/cssquery-ext.html) 18:57:23 INFO - PROCESS | 7407 | RSS: Main: 159141888 18:57:23 INFO - PROCESS | 7407 | 19:00:25 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-ext.html (next: http://localhost:51567/tests/dromaeo/cssquery-jquery.html) 19:00:25 INFO - PROCESS | 7407 | RSS: Main: 154120192 19:00:25 INFO - PROCESS | 7407 | 19:03:27 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51567/tests/dromaeo/cssquery-mootools.html) 19:03:28 INFO - PROCESS | 7407 | RSS: Main: 154505216 19:03:28 INFO - PROCESS | 7407 | 19:06:30 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51567/tests/dromaeo/cssquery-prototype.html) 19:06:30 INFO - PROCESS | 7407 | RSS: Main: 153214976 19:06:30 INFO - PROCESS | 7407 | 19:09:33 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51567/tests/dromaeo/cssquery-yui.html) 19:09:33 INFO - PROCESS | 7407 | RSS: Main: 155734016 19:09:33 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | Cycle 1(1): loaded http://localhost:51567/tests/dromaeo/cssquery-yui.html (next: http://localhost:51567/tests/dromaeo/cssquery-dojo.html) 19:12:36 INFO - PROCESS | 7407 | RSS: Main: 156139520 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | __start_tp_report 19:12:36 INFO - PROCESS | 7407 | _x_x_mozilla_page_load 19:12:36 INFO - PROCESS | 7407 | _x_x_mozilla_page_load_details 19:12:36 INFO - PROCESS | 7407 | |i|pagename|runs| 19:12:36 INFO - PROCESS | 7407 | |0;dojo.html;3258.2831777009055;3279.376918385505;3279.7048265656094;3300.3729291434643;3302.9669703302975;5700.059490184115;5784.334801497829;5785.074388097905;5806;5806.361300256968;5772.855678608037;5820.272465941757;5836.949349117168;5843.79546715865;5846.6199697019665;5237.502437268472;5267.473252674721;5288.762005709733;5308.5487733542695;5314;5161.380634323887;5185.714785686786;5185.792568297264;5200.947990520084;5209.453007434222;5189.584833213353;5194.454582268864;5203.713795741232;5206.505381988705;5245.134552798783;5185.144451165553;5233.084210263208;5238.266642670029;5243.10867152585;5259.86850328741;4998.750062496861;5075;5083.872903177413;5113.872153196163;5144.922826157611;5643.238162848045;5692.089265717506;5699.373068962411;5705.77176912923;5715.828525144252;6118.632882027093;6119.112728654365;6121.938780612181;6138.294096178907;6158.507319414436;5947.791827286068;6097.57316987811;6110.083487476914;6128;6135.018317212185;5767.682777447197;5797.826065218051;5805.158252053471;5832.854178645568;5839.328477225088;6294.9685251574365;6302.369763023753;6345.04824276353;6350.110984462179;6366.236051673829;5928.970355148197;5953.583249172603;5978.28260608721;5998.610090344201;6072.90890636632;6129.725578588854;6134.9079763803575;6142.464383904024;6144.969275153685;6146.0473626587955;6072.635641861502;6079.331273559905;6117.602355846856;6135.723892424851;6151.692415379213;5917.852053698692;6116.969415152896;6120.540959427972;6127.433875357673;6142.877142457126;4742.478327383985;4757.976210118927;4758.2386818108935;4759.048190361941;4770.260609605517;4210.599993000721;4235.068284977362;4236.745795252295;4245.214635292481;4248.660107191417;5697.202391665171;5831.358550559435;5832.88334233313;5847.210626565445;5954.19618351517;6195.721192546346;6200.751969921243;6202.627842329474;6209.472194863397;6224.782132625336;5922.970385148046;5935.109733539917;5951.345352011275;5958.6424814511265;6004.219451471368;5138.768755406016;5219.556337711261;5242.0302244084205;5248.3701955765555;5318.521333080042;6342.334054924258;6342.714577844008;6344.175257216532;6344.968275158687;6352.936470635234;6093.9085913712215;6127.724252408741;6136.570440069331;6148;6156.415140561639;6245.469135123565;6287.685615719104;6322.589031712924;6345.238571371465;6346.238451385863;6120.508083830795;6128.353235766433;6128.903521899524;6130.398136741914;6140.04415716754;6195.535334849814;6196.752129914933;6241.251049874044;6251.749930002749;6257.342978987323;5824.767009319579;5973.462388385066;5974.40255974399;6009.669468179292;6074.36219196978;6085.087236914321;6090.665013424305;6092.786752463642;6097.878042439215;6113.14415981754;5986.9401305986385;5988.700564971647;6040.939590604214;6050;6061.393860613904;5802.796902108406;6021.42796434338;6033.909491357545;6041.18444010053;6056.515478761777;5946.197263369563;5951.821445356646;5964.522838172849;5975.312839023568;5985.102234664835 19:12:36 INFO - PROCESS | 7407 | |1;ext.html;552.552312940097;601.3925934805847;616.9198004259446;667.8063361625129;696.7665831946298;40644.39033414498;45135;45194.548054519444;45355.77322113385;45384.31923521146;45204.32193517092;45503.54496455035;45678.54321456784;45823.77088114563;45845.770771146184;8921.553922303876;9116.088391160863;9159.313051521129;9162.72511824643;9187.816243675123;8769.868451973225;8781.912180878206;8809.603567839431;8815.294776417903;8859.734207973772;8783.780405489882;8815.294776417872;8876.644934202624;8889.599968001423;8892.421992570495;9085.909140908605;9093.40892841963;9105.590248438803;9115;9116.908830911738;8850.468971861708;8875.156860098281;8919.42023768453;8948.55257237142;8971.372003959725;43690.56309436897;44211;44368;44444;44462.11075778466;3687.6865466435383;3702.740808143431;3844.596317386662;3848.3265428549894;3902.7853468059247;35002;35149.82425087884;35405.82297088498;35845.92462226137;35963.82018089919;4780.306855505932;4799.352087468217;4831.975840120777;4857.34425852509;4934.432540257881;371636;375690;376298;377682;377782;66158.33841661522;66206;66447.66776166185;66484.33515664781;66562.66718666472;33123.66876331206;33306;33754.66245337564;34823.30353392918;34921;15941.601459963595;16111.113888736232;16161.757573636405;16190;16221.35114595403;11957.103217258566;11989.520419183134;12025.759484810254;12032.157748957488;12070.879291207151;20356.69464958027;21025.684614730486;21030.684539731916;21102.683459748117;21210.575788484453;7336.449766267551;7491.887621685679;7714.498557593738;7716.6527506262355;7778.105517865405;1067.7330667333167;1079.3092420850662;1082.7888561730545;1146.1919346860443;1199.196538319328;33433.83283083569;34624.82687586546;37401;37613.059673507836;37643.24713505714;1129.4239937631703;1152.181950814914;1203.169812829145;1204.8313236146946;1250.6435665835193;16979.830201697823;17183.828161718473;17186.31254749796;17367.739483907753;17712.734308985375;434044;613824;619028;621457;624802;65002.34997649963;65100.67449662816;65401.67299163474;65431.67284163549;65526.34473655298;1442.3365251984205;1461.2547600723708;1485.9405623774928;1490.4336352186099;1500.46733409638;33789;34196.316073678885;34320;34778.652213477544;34827.65172348244;54213.18680219879;54669.453305466435;54829.72585137049;54843.45156548383;54846.17730734122;517470;518691;520762;521601;523978;29671;30128;30201.244968875075;30515.2371190722;30575.08274751761;51011.30991562426;51962.740186298826;52363.73818130885;52453.7377313111;52529.737351313;42254.78872605618;42526.36210456784;43625.78187109171;44343.77828110839;44870.551294486635;42159.578404215565;43494.78252608717;44018.119637607706;44127;44376;39025.41461878131;39626.2074758509;39650.60349396469;41629.167416652104;41814.79092604518;37030;37856.810715946245;38106.23787524289;38787.80606096952;39024.80487597544;29039.709602903702;29313.56029659514;29551;29667.406651867273;29698.406031879673 19:12:36 INFO - PROCESS | 7407 | |2;jquery.html;397.3800870641801;398.9421533877586;403.7496752013751;407.8022159252762;417.5407052242534;15128.470503532351;18180.181891814867;19473.221071157153;19643.901780491076;20289.391318260437;20534.38396848093;20744.792552074512;21134.365969020917;21193.152273909065;21272;5705.914411283834;5872.060470324749;5933.910991335133;5948.940510594904;5973.074173503114;5985.371535988724;5992.610480318787;6041.093835924603;6042.969785151068;6105.450509454148;5683.204351390808;5976.73104710289;6055.455009049185;6061.090836374535;6072.969635151818;5656.773729050833;5670.546356291507;5763.279590051244;5785.681787501686;5796.13058041293;5274.709890955995;5417.133258678593;5421.969825733098;5434.7826086956475;5440.591955603346;19999.700004499944;24929.252122436355;25516.74483255181;25601.103961361263;25661.74338256612;2621.423286876884;2630.237231202949;2646.3913299941123;2885.639295088114;3236.1100697308193;10456.634017809416;10742.248042637018;10961.945190273998;16044.117573533567;16178.595535111599;1948.3570421760926;2009.336918816787;2011.4669612552684;2050.7231523744404;2080.4278823323557;75700.99999999945;82690.17309826885;85532.57233713854;86880;87599;10607.522661480252;11014.44927753609;11051.392173430539;11178.664640060812;11386.601468948713;15814.76277855833;15855.762163567555;15865.127417991891;15866.761998570031;15903;8008.159143289987;8213.219744124299;8277.503349799032;8408.873866892001;8436.662533498591;7880.408969327324;7894.407919406068;7941.166177551389;8003.119656837744;8083.757487275391;4739.049208999093;4807.158747219222;4887.875788568649;4890.364252647133;4977.601791856643;1941.7475728155262;1999.152056263555;2013.788552202027;2031.4007367826528;2048.365006847882;931.4783721116197;986.1124987511154;1028.665683652816;1048.7692707604315;1068.5779117248644;20041.599168016557;20908;20918.477038073866;21171.68242476364;21233.150673973178;1048.2924026282228;1096.855746548684;1109.14595761265;1118.959367787965;1120.2270433400927;11018.889811101786;11181.664550063511;11252.49363778632;11781;11805;517851;524383;525532;526137;536782;59317.703411483526;77136.61431692805;97248.51375743076;99693.50153249332;100626.49686751666;1033.503918119292;1049.5434485998462;1064.7551063255494;1071.3036526257995;1074.2533938912536;18149.27402903869;18665.6266874659;18949.95529492851;19004.14481348315;19237;34345.82827085849;43858.342124867515;44338.334924975505;44532.554674454135;45889.31166032579;58763.412365877506;60323;60684.393156069644;62208.06687899776;69505.30494694988;8787.5166865823;8916.55417229149;8979.595918183828;9022.86465703028;9143.177114059767;11737;13870.167789932637;13873.930630346784;13908;14390.208538530482;12247.632571022883;12547.811782823082;12565.120441569003;12799.42402591867;12842.67893302675;11937.701557461132;12277.75444491123;12373.381330933238;12421;12441.440135193758;12668.619941401772;12846.743065138831;12869;12929;13025.674358141123;8688.565571721263;8816.603252853509;8911.598978046133;9097.1812536872;9130.589123489592;9011.324150688593;11563.6530904073;12092.939535302266;12145.332006739714;12327.075469339656 19:12:36 INFO - PROCESS | 7407 | |3;mootools.html;1300.889424398926;1326.5091915991084;1454.919979401133;1843.7510936023632;1872.1762424533197;8447.831043379128;9081.954590227047;9110.316726245524;9736.610535578586;9767.072128147824;9210.631574737003;9505.762355941104;9510.524473776319;9514.42913425195;9521.857172142423;2454.4968281502292;2472.6167444046114;2489.539435204484;2491.364702000987;2494.837835540693;2437.914672986446;2524.4951009798115;2526.431552900601;2526.6589010483626;2536.2898388451263;2482.391814005571;2491.364702000996;2531.493701259755;2537.2768760903145;2540.0220914947695;2469.937926691522;2471.752824717541;2475.170817776047;2490.7882829959476;2496.6255061740703;2442.3161514775893;2449.6815413996246;2470.1848390031246;2481.1564068216894;2482.925512234636;9472.336936414455;9533.380330278578;9645.614175432975;9656.27577931658;9673.129418352382;5596.888062238732;5677.971610141964;5683.232763576947;5686.488216060575;5717.171010203539;3529.7882127072457;3554.875579354736;3584.956574752392;3639.344917914774;3647.598764135943;1183.1185766603935;1193.0813273779142;1211.3095535544744;1228.4901765767195;1247.1145486704452;12959.805602915963;12989.090763646549;12994.545190918272;13010.674733131653;13026.54407095747;4902.313676085351;4968.329275547755;5009.24861270805;5055.115354812893;5059.696418214919;10807.027367536803;10824.15989281824;10836.187285953585;10882.782344353069;10923.617673381394;5724.427557244242;5735.254416925773;5752.913706294409;5757.884842303214;5769.048107062287;4658.720476771405;5106.285120083191;5216.1393370094265;5245.10833158364;5288.444713305047;4177.6866734995;4258.467691538558;4310.181065597527;4330.047389574289;4363.869083927487;1317.8879795217515;1321.3459337627935;1338.3375229261578;1341.9194848309132;1343.0464370297002;925.8287216864901;968.4721826604376;1048.3971716263027;1060.48566445274;1061.6178175856685;6438.25960014595;6497.090407342881;6515.934840651627;6589.110470086573;6703.966480167568;494.90101979604225;508.6464906889676;509.05062059259217;511.15148852904;513.8304359561336;4547.727136371828;4576.794044268016;4613.446386433649;4653.95346046542;4670.439547254351;11376.943115284535;11840.70398240051;11909.523619055313;11932.582359617372;11952.282863028246;11157.442127893573;11651.825222621668;11684.415779211175;11859.822102668468;11934.462949167135;8701.30389568833;8849.070847560914;8857.291416686778;8861.24679402245;8885.333599980027;6638.20341559016;6802.965985170043;6849.828754281183;6918.481113916376;6923.653817309215;10789.190810689386;10921.78156436851;10940;10954.452277385939;10963.287386319864;11023.944880275869;11062.22564420483;11070;11157.609483668033;11262.38056906878;7772.261635144652;8596.269317108116;8599.871001934851;8714.477131371885;8907.554622268732;8947.150020748019;9154.816903662022;9162.816743665222;9174.816503669756;9226.584803683716;7904.367650587824;8139.267465927858;8154.1030486647605;8228.136045715113;8263.793405164919;7871.212878712312;8107.594620268845;8170.305524030524;8211.917880821115;8346.540940248344;7474.962625186839;7488.063992001;7531.3598344141365;7541.585212813348;7614.200508946481;5640.971795141162;5720.2849643794525;5739.684317362585;5774.307083150049;5816.854578635568;5617.185508101385;5695.373508913934;5748.856278592902;5774.1338799178775;5960.791372301948 19:12:36 INFO - PROCESS | 7407 | |4;prototype.html;343.6048544174199;349.8548102537447;350.7755036776463;358.2744941493477;358.5160033954161;5770.3364113127;5832.941670583298;5884.941150588504;5900.822975310743;5920.733566989485;5722.685252311121;5728.971355143229;5761.300416377168;5762.3949485303965;5781.595288329808;4285.742855428676;4444.866654000385;4484.843030493933;4492.213862574053;4519.864404067883;4465.771912724011;4498.820047198108;4501.414816073906;4518.43519560055;4546.47715512717;4461.83992162037;4496.168208881351;4506.864794056183;4519.5932366087045;4536.9773151134195;4409.647228221735;4432.135733531963;4446.133004064209;4447.444069491314;4458.576435238663;3946.980265098656;3958.5843486433796;3964.2953529982096;3968.7023473239333;3986.461827653288;5605;5638.661680299195;5639.984802735506;5658.321001479849;5661.575381846378;5070.163423035195;5081.577158395655;5132.769025393866;5143.614228932845;5169.508896654812;5952.494038006731;6008.519318454513;6017.398260173992;6025.216721826178;6047.365026672224;4306.26793445112;4329.502107257674;4358.978205108954;4384.057427653038;4386.670999675005;6013.338532761437;6016.879662406771;6112.144299798077;6246.15676883624;6253.499160201564;4369.890752731207;4372.23485889968;4411.845585404495;4413.7793110345;4418.298954902386;4465.307877279027;4472.664550158751;4475.7985890634345;4481.731096134177;4492.05666809967;4944.431390390079;5025.47232540578;5128.743562821844;5139.12634852076;5148.948510514847;5989.562504998769;6002.639841609517;6040.546958978094;6080.14877917092;6109.419605137505;1508.1780429665857;1525.2297589717123;1530.7856900034003;1546.6983938132182;1550.4573399310152;989.4310771306527;1032.7573020340214;1036.5540071600076;1048.5910494906993;1059.6979860739652;5151.866589350337;5195.870103247449;5198.376194856642;5203.531682148625;5266.605004624668;5431.646942948775;5467.906418716273;5549.448353054048;5561.888762224733;5588.804391846266;4981.708414129468;5222.216667499905;5241.663375839136;5312.9734351328;5350.384705758887;2920.269932516871;2945.7038902882664;2952.4980753271993;2973.6728959814404;2990.220818612922;5639;5680.943190568041;5713.457221563945;5723.855228954226;5735.311762588516;5959.404059594006;6414.518911081687;6444.516661250425;6444.903326450013;6465;6525.282218955911;6534.607923524603;6584.473242140617;6608.207015158212;6641.767538136142;6136.2636483622255;6257.624542527463;6329.177206963065;6341.365863413622;6383.904241436475;6261.24865016201;6271.153394291712;6337;6342.460890824332;6367.490600752021;6256.562040657111;6372.58578192416;6432.195975503062;6433.616772393958;6485.189351331083;4366.235908716026;4401.515833258275;4418.293073108287;4424.690271680952;4436.977815110904;6242.7838117467645;6291.653959032297;6321.431071203614;6354.332795056453;6407.327230640902;6080.543959203166;6081.543884208791;6092.634441933498;6092.8781424372155;6175.876482470415;5903.498202652822;6120;6133.172021777182;6136.189824001841;6173.197484327009;5912.763489460545;5935.198748168942;5981.700914954322;6004.42957918997;6012.398760123952;6067.908981365194;6085.939140608537;6096.908546371897;6099.420555047441;6152.169457123231;5806.7225210453635;5936.1986131871645;5977;5977.581569290108;5981.222441082631 19:12:36 INFO - PROCESS | 7407 | |5;yui.html;801.8556659801241;802.546561192926;813.6745301879248;819.1808191808192;852.9829403411932;15481.303341349638;17065.232064557094;17324.393646222386;17331.133443327846;17360.218790154442;16003.919980400082;16130.274137663804;16259.105749183791;16267.51197464078;16311.59221019475;720.6108701301291;862.8403745307107;867.4621734524573;871.5816408124105;873.2620935309685;877.473515890467;878.5431575580726;881.6120906801019;886.0120965123873;887.8002449448887;924.9213816825578;931.6739141300525;933.7712260496154;934.0612684252351;939.0515579264958;930.9487978161164;932.4405356785942;934.9532523373838;937.6015193542751;939.5349302095507;690.9136357955256;692.1935944624506;692.5706062241443;693.2616763147232;694.6908625661582;15516.689666206612;15556.299966501534;15581.688366232725;15583.532494025198;15592.37630494779;13767.449302027906;14672.486462973744;14957.70084598302;15371;15500.457483988006;14401.423943042266;14809.185494797783;15095.622609434742;15126.394944202219;15166.848331516654;5001.724905130252;5009.674371165899;5025.924611130836;5110.10573149701;5149.30484384607;82286.58856705738;82319.17680823174;83961.58019209864;85432.57283713603;91523;12606.495740170474;12687.238765674088;12854.678633034062;12959.287239201934;13191.208527488381;21733.456663583536;21780.78219217819;21986.780132198473;22044.779552204593;22906.65640015401;9276.35065545419;9832.213422926148;9855.852162217572;10008.799824003625;10031.799364012824;5294.682319060868;5372.140457526855;5402.324709411324;5450.8909821803345;5501.504864562208;4006.098627808778;4114.259433302034;4155.148194620096;4158.209940111369;4187.78554219273;712.3553184368155;715.7045747197485;723.9710411583583;727.8398752274597;735.8344372516248;697.5465947134403;744.7318965172534;762.7406681728239;833.7790485521342;843.8270154618289;10356.533955972;10726.892731072745;10861.891381086247;11014.339139651647;11549.538018479167;705.1608585783005;748.8389996150745;756.9659365328573;794.1581923161467;802.9076656184614;5127.974360128175;5390.029794636925;5421.680780468432;5483.204935284361;5488.506034456918;73821;75069.24930750622;75405.62297188479;98305;120953.79046209426;113925;114853;116113;116253.41873290579;119553;65387;93001;93714.82129592162;100471;103493.48253258686;10073.093421592092;10181.287309888534;10250;10329.741756455847;10405.167586592903;48890;49036.509634903196;59404;60858.39141608704;62617.37382626298;50293.74853125857;54201.728991354794;76599.61700191464;77169.2283077162;77755;13424.798628020391;14037.578872633838;14084.436622534984;14236.145831250158;14236.359363828446;16437.342506299614;16439.424620138238;16463.34146634169;16646.583835404213;16858.831411686217;14690.926545367205;14857.257137142884;15346;15636.140012299433;16166;14998.2500874958;15067;15364.769528457306;15630.765538517158;16271.837281627033;14487.92756036213;14590.781138282722;14614.780778288547;15129.546113616609;15404.537863864101;12359.752804943671;12934.417951192407;13077.542286019943;13208.471661133832;13686.110402823784;13163.276019818619;13500.5274815381;13525.323733813466;13566;13582.53532045594 19:12:36 INFO - PROCESS | 7407 | __end_tp_report 19:12:36 INFO - PROCESS | 7407 | __start_cc_report 19:12:36 INFO - PROCESS | 7407 | _x_x_mozilla_cycle_collect,318 19:12:36 INFO - PROCESS | 7407 | __end_cc_report 19:12:36 INFO - PROCESS | 7407 | __startTimestamp1472868756517__endTimestamp 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | ------- Summary: start ------- 19:12:36 INFO - PROCESS | 7407 | Number of tests: 6 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | [#0] dojo.html Cycles:165 Average:5717.06 Median:5964.52 stddev:654.20 (11.0%) stddev-sans-first:627.13 19:12:36 INFO - PROCESS | 7407 | Values: 3258.3 3279.4 3279.7 3300.4 3303.0 5700.1 5784.3 5785.1 5806.0 5806.4 5772.9 5820.3 5836.9 5843.8 5846.6 5237.5 5267.5 5288.8 5308.5 5314.0 5161.4 5185.7 5185.8 5200.9 5209.5 5189.6 5194.5 5203.7 5206.5 5245.1 5185.1 5233.1 5238.3 5243.1 5259.9 4998.8 5075.0 5083.9 5113.9 5144.9 5643.2 5692.1 5699.4 5705.8 5715.8 6118.6 6119.1 6121.9 6138.3 6158.5 5947.8 6097.6 6110.1 6128.0 6135.0 5767.7 5797.8 5805.2 5832.9 5839.3 6295.0 6302.4 6345.0 6350.1 6366.2 5929.0 5953.6 5978.3 5998.6 6072.9 6129.7 6134.9 6142.5 6145.0 6146.0 6072.6 6079.3 6117.6 6135.7 6151.7 5917.9 6117.0 6120.5 6127.4 6142.9 4742.5 4758.0 4758.2 4759.0 4770.3 4210.6 4235.1 4236.7 4245.2 4248.7 5697.2 5831.4 5832.9 5847.2 5954.2 6195.7 6200.8 6202.6 6209.5 6224.8 5923.0 5935.1 5951.3 5958.6 6004.2 5138.8 5219.6 5242.0 5248.4 5318.5 6342.3 6342.7 6344.2 6345.0 6352.9 6093.9 6127.7 6136.6 6148.0 6156.4 6245.5 6287.7 6322.6 6345.2 6346.2 6120.5 6128.4 6128.9 6130.4 6140.0 6195.5 6196.8 6241.3 6251.7 6257.3 5824.8 5973.5 5974.4 6009.7 6074.4 6085.1 6090.7 6092.8 6097.9 6113.1 5986.9 5988.7 6040.9 6050.0 6061.4 5802.8 6021.4 6033.9 6041.2 6056.5 5946.2 5951.8 5964.5 5975.3 5985.1 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | [#1] ext.html Cycles:180 Average:65241.16 Median:43560.28 stddev:133655.50 (306.8%) stddev-sans-first:133942.19 19:12:36 INFO - PROCESS | 7407 | Values: 552.6 601.4 616.9 667.8 696.8 40644.4 45135.0 45194.5 45355.8 45384.3 45204.3 45503.5 45678.5 45823.8 45845.8 8921.6 9116.1 9159.3 9162.7 9187.8 8769.9 8781.9 8809.6 8815.3 8859.7 8783.8 8815.3 8876.6 8889.6 8892.4 9085.9 9093.4 9105.6 9115.0 9116.9 8850.5 8875.2 8919.4 8948.6 8971.4 43690.6 44211.0 44368.0 44444.0 44462.1 3687.7 3702.7 3844.6 3848.3 3902.8 35002.0 35149.8 35405.8 35845.9 35963.8 4780.3 4799.4 4832.0 4857.3 4934.4 371636.0 375690.0 376298.0 377682.0 377782.0 66158.3 66206.0 66447.7 66484.3 66562.7 33123.7 33306.0 33754.7 34823.3 34921.0 15941.6 16111.1 16161.8 16190.0 16221.4 11957.1 11989.5 12025.8 12032.2 12070.9 20356.7 21025.7 21030.7 21102.7 21210.6 7336.4 7491.9 7714.5 7716.7 7778.1 1067.7 1079.3 1082.8 1146.2 1199.2 33433.8 34624.8 37401.0 37613.1 37643.2 1129.4 1152.2 1203.2 1204.8 1250.6 16979.8 17183.8 17186.3 17367.7 17712.7 434044.0 613824.0 619028.0 621457.0 624802.0 65002.3 65100.7 65401.7 65431.7 65526.3 1442.3 1461.3 1485.9 1490.4 1500.5 33789.0 34196.3 34320.0 34778.7 34827.7 54213.2 54669.5 54829.7 54843.5 54846.2 517470.0 518691.0 520762.0 521601.0 523978.0 29671.0 30128.0 30201.2 30515.2 30575.1 51011.3 51962.7 52363.7 52453.7 52529.7 42254.8 42526.4 43625.8 44343.8 44870.6 42159.6 43494.8 44018.1 44127.0 44376.0 39025.4 39626.2 39650.6 41629.2 41814.8 37030.0 37856.8 38106.2 38787.8 39024.8 29039.7 29313.6 29551.0 29667.4 29698.4 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | [#2] jquery.html Cycles:180 Average:30482.81 Median:25558.92 stddev:86537.71 (338.6%) stddev-sans-first:86750.99 19:12:36 INFO - PROCESS | 7407 | Values: 397.4 398.9 403.7 407.8 417.5 15128.5 18180.2 19473.2 19643.9 20289.4 20534.4 20744.8 21134.4 21193.2 21272.0 5705.9 5872.1 5933.9 5948.9 5973.1 5985.4 5992.6 6041.1 6043.0 6105.5 5683.2 5976.7 6055.5 6061.1 6073.0 5656.8 5670.5 5763.3 5785.7 5796.1 5274.7 5417.1 5422.0 5434.8 5440.6 19999.7 24929.3 25516.7 25601.1 25661.7 2621.4 2630.2 2646.4 2885.6 3236.1 10456.6 10742.2 10961.9 16044.1 16178.6 1948.4 2009.3 2011.5 2050.7 2080.4 75701.0 82690.2 85532.6 86880.0 87599.0 10607.5 11014.4 11051.4 11178.7 11386.6 15814.8 15855.8 15865.1 15866.8 15903.0 8008.2 8213.2 8277.5 8408.9 8436.7 7880.4 7894.4 7941.2 8003.1 8083.8 4739.0 4807.2 4887.9 4890.4 4977.6 1941.7 1999.2 2013.8 2031.4 2048.4 931.5 986.1 1028.7 1048.8 1068.6 20041.6 20908.0 20918.5 21171.7 21233.2 1048.3 1096.9 1109.1 1119.0 1120.2 11018.9 11181.7 11252.5 11781.0 11805.0 517851.0 524383.0 525532.0 526137.0 536782.0 59317.7 77136.6 97248.5 99693.5 100626.5 1033.5 1049.5 1064.8 1071.3 1074.3 18149.3 18665.6 18950.0 19004.1 19237.0 34345.8 43858.3 44338.3 44532.6 45889.3 58763.4 60323.0 60684.4 62208.1 69505.3 8787.5 8916.6 8979.6 9022.9 9143.2 11737.0 13870.2 13873.9 13908.0 14390.2 12247.6 12547.8 12565.1 12799.4 12842.7 11937.7 12277.8 12373.4 12421.0 12441.4 12668.6 12846.7 12869.0 12929.0 13025.7 8688.6 8816.6 8911.6 9097.2 9130.6 9011.3 11563.7 12092.9 12145.3 12327.1 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | [#3] mootools.html Cycles:180 Average:6246.53 Median:2731.62 stddev:3556.47 (130.2%) stddev-sans-first:3547.02 19:12:36 INFO - PROCESS | 7407 | Values: 1300.9 1326.5 1454.9 1843.8 1872.2 8447.8 9082.0 9110.3 9736.6 9767.1 9210.6 9505.8 9510.5 9514.4 9521.9 2454.5 2472.6 2489.5 2491.4 2494.8 2437.9 2524.5 2526.4 2526.7 2536.3 2482.4 2491.4 2531.5 2537.3 2540.0 2469.9 2471.8 2475.2 2490.8 2496.6 2442.3 2449.7 2470.2 2481.2 2482.9 9472.3 9533.4 9645.6 9656.3 9673.1 5596.9 5678.0 5683.2 5686.5 5717.2 3529.8 3554.9 3585.0 3639.3 3647.6 1183.1 1193.1 1211.3 1228.5 1247.1 12959.8 12989.1 12994.5 13010.7 13026.5 4902.3 4968.3 5009.2 5055.1 5059.7 10807.0 10824.2 10836.2 10882.8 10923.6 5724.4 5735.3 5752.9 5757.9 5769.0 4658.7 5106.3 5216.1 5245.1 5288.4 4177.7 4258.5 4310.2 4330.0 4363.9 1317.9 1321.3 1338.3 1341.9 1343.0 925.8 968.5 1048.4 1060.5 1061.6 6438.3 6497.1 6515.9 6589.1 6704.0 494.9 508.6 509.1 511.2 513.8 4547.7 4576.8 4613.4 4654.0 4670.4 11376.9 11840.7 11909.5 11932.6 11952.3 11157.4 11651.8 11684.4 11859.8 11934.5 8701.3 8849.1 8857.3 8861.2 8885.3 6638.2 6803.0 6849.8 6918.5 6923.7 10789.2 10921.8 10940.0 10954.5 10963.3 11023.9 11062.2 11070.0 11157.6 11262.4 7772.3 8596.3 8599.9 8714.5 8907.6 8947.2 9154.8 9162.8 9174.8 9226.6 7904.4 8139.3 8154.1 8228.1 8263.8 7871.2 8107.6 8170.3 8211.9 8346.5 7475.0 7488.1 7531.4 7541.6 7614.2 5641.0 5720.3 5739.7 5774.3 5816.9 5617.2 5695.4 5748.9 5774.1 5960.8 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | [#4] prototype.html Cycles:180 Average:5030.61 Median:5638.83 stddev:1495.23 (26.5%) stddev-sans-first:1457.45 19:12:36 INFO - PROCESS | 7407 | Values: 343.6 349.9 350.8 358.3 358.5 5770.3 5832.9 5884.9 5900.8 5920.7 5722.7 5729.0 5761.3 5762.4 5781.6 4285.7 4444.9 4484.8 4492.2 4519.9 4465.8 4498.8 4501.4 4518.4 4546.5 4461.8 4496.2 4506.9 4519.6 4537.0 4409.6 4432.1 4446.1 4447.4 4458.6 3947.0 3958.6 3964.3 3968.7 3986.5 5605.0 5638.7 5640.0 5658.3 5661.6 5070.2 5081.6 5132.8 5143.6 5169.5 5952.5 6008.5 6017.4 6025.2 6047.4 4306.3 4329.5 4359.0 4384.1 4386.7 6013.3 6016.9 6112.1 6246.2 6253.5 4369.9 4372.2 4411.8 4413.8 4418.3 4465.3 4472.7 4475.8 4481.7 4492.1 4944.4 5025.5 5128.7 5139.1 5148.9 5989.6 6002.6 6040.5 6080.1 6109.4 1508.2 1525.2 1530.8 1546.7 1550.5 989.4 1032.8 1036.6 1048.6 1059.7 5151.9 5195.9 5198.4 5203.5 5266.6 5431.6 5467.9 5549.4 5561.9 5588.8 4981.7 5222.2 5241.7 5313.0 5350.4 2920.3 2945.7 2952.5 2973.7 2990.2 5639.0 5680.9 5713.5 5723.9 5735.3 5959.4 6414.5 6444.5 6444.9 6465.0 6525.3 6534.6 6584.5 6608.2 6641.8 6136.3 6257.6 6329.2 6341.4 6383.9 6261.2 6271.2 6337.0 6342.5 6367.5 6256.6 6372.6 6432.2 6433.6 6485.2 4366.2 4401.5 4418.3 4424.7 4437.0 6242.8 6291.7 6321.4 6354.3 6407.3 6080.5 6081.5 6092.6 6092.9 6175.9 5903.5 6120.0 6133.2 6136.2 6173.2 5912.8 5935.2 5981.7 6004.4 6012.4 6067.9 6085.9 6096.9 6099.4 6152.2 5806.7 5936.2 5977.0 5977.6 5981.2 19:12:36 INFO - PROCESS | 7407 | 19:12:36 INFO - PROCESS | 7407 | [#5] yui.html Cycles:180 Average:21637.72 Median:4060.18 stddev:30036.09 (739.8%) stddev-sans-first:30079.61 19:12:36 INFO - PROCESS | 7407 | Values: 801.9 802.5 813.7 819.2 853.0 15481.3 17065.2 17324.4 17331.1 17360.2 16003.9 16130.3 16259.1 16267.5 16311.6 720.6 862.8 867.5 871.6 873.3 877.5 878.5 881.6 886.0 887.8 924.9 931.7 933.8 934.1 939.1 930.9 932.4 935.0 937.6 939.5 690.9 692.2 692.6 693.3 694.7 15516.7 15556.3 15581.7 15583.5 15592.4 13767.4 14672.5 14957.7 15371.0 15500.5 14401.4 14809.2 15095.6 15126.4 15166.8 5001.7 5009.7 5025.9 5110.1 5149.3 82286.6 82319.2 83961.6 85432.6 91523.0 12606.5 12687.2 12854.7 12959.3 13191.2 21733.5 21780.8 21986.8 22044.8 22906.7 9276.4 9832.2 9855.9 10008.8 10031.8 5294.7 5372.1 5402.3 5450.9 5501.5 4006.1 4114.3 4155.1 4158.2 4187.8 712.4 715.7 724.0 727.8 735.8 697.5 744.7 762.7 833.8 843.8 10356.5 10726.9 10861.9 11014.3 11549.5 705.2 748.8 757.0 794.2 802.9 5128.0 5390.0 5421.7 5483.2 5488.5 73821.0 75069.2 75405.6 98305.0 120953.8 113925.0 114853.0 116113.0 116253.4 119553.0 65387.0 93001.0 93714.8 100471.0 103493.5 10073.1 10181.3 10250.0 10329.7 10405.2 48890.0 49036.5 59404.0 60858.4 62617.4 50293.7 54201.7 76599.6 77169.2 77755.0 13424.8 14037.6 14084.4 14236.1 14236.4 16437.3 16439.4 16463.3 16646.6 16858.8 14690.9 14857.3 15346.0 15636.1 16166.0 14998.3 15067.0 15364.8 15630.8 16271.8 14487.9 14590.8 14614.8 15129.5 15404.5 12359.8 12934.4 13077.5 13208.5 13686.1 13163.3 13500.5 13525.3 13566.0 13582.5 19:12:36 INFO - PROCESS | 7407 | -------- Summary: end -------- 19:12:36 INFO - PROCESS | 7407 | 19:12:37 INFO - TEST-INFO | 7407: exit 0 19:12:37 INFO - TEST-OK | dromaeo_css | took 1111123ms 19:12:37 INFO - TEST-START | kraken 19:12:37 INFO - operating with platform_type : linux_ 19:12:37 INFO - Initialising browser for kraken test... 19:12:37 INFO - TEST-INFO | started process 7670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphH2v_I/profile http://localhost:51567/getInfo.html) 19:12:41 INFO - PROCESS | 7670 | __metrics Screen width/height:1600/1200 19:12:41 INFO - PROCESS | 7670 | colorDepth:24 19:12:41 INFO - PROCESS | 7670 | Browser inner width/height: 1024/697 19:12:41 INFO - PROCESS | 7670 | __metrics 19:12:42 ERROR - PROCESS | 7670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:12:43 INFO - TEST-INFO | 7670: exit 0 19:12:43 INFO - Browser initialized. 19:12:43 INFO - Running cycle 1/1 for kraken test... 19:12:43 INFO - TEST-INFO | started process 7796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphH2v_I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:54 INFO - PROCESS | 7796 | RSS: Main: 152440832 19:12:54 INFO - PROCESS | 7796 | 19:12:57 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-beat-detection) 19:12:58 INFO - PROCESS | 7796 | RSS: Main: 158072832 19:12:58 INFO - PROCESS | 7796 | 19:13:00 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-dft) 19:13:01 INFO - PROCESS | 7796 | RSS: Main: 156516352 19:13:01 INFO - PROCESS | 7796 | 19:13:04 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-fft) 19:13:05 INFO - PROCESS | 7796 | RSS: Main: 157528064 19:13:05 INFO - PROCESS | 7796 | 19:13:07 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51567/tests/kraken/driver.html?testName=audio-oscillator) 19:13:07 INFO - PROCESS | 7796 | RSS: Main: 157270016 19:13:07 INFO - PROCESS | 7796 | 19:13:10 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:10 INFO - PROCESS | 7796 | RSS: Main: 157409280 19:13:10 INFO - PROCESS | 7796 | 19:13:13 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51567/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:14 INFO - PROCESS | 7796 | RSS: Main: 156684288 19:13:14 INFO - PROCESS | 7796 | 19:13:17 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51567/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:18 INFO - PROCESS | 7796 | RSS: Main: 157458432 19:13:18 INFO - PROCESS | 7796 | 19:13:21 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51567/tests/kraken/driver.html?testName=json-parse-financial) 19:13:21 INFO - PROCESS | 7796 | RSS: Main: 157147136 19:13:21 INFO - PROCESS | 7796 | 19:13:23 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:24 INFO - PROCESS | 7796 | RSS: Main: 157077504 19:13:24 INFO - PROCESS | 7796 | 19:13:25 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:26 INFO - PROCESS | 7796 | RSS: Main: 157069312 19:13:26 INFO - PROCESS | 7796 | 19:13:28 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:29 INFO - PROCESS | 7796 | RSS: Main: 157409280 19:13:29 INFO - PROCESS | 7796 | 19:13:31 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:32 INFO - PROCESS | 7796 | RSS: Main: 158232576 19:13:32 INFO - PROCESS | 7796 | 19:13:34 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:35 INFO - PROCESS | 7796 | RSS: Main: 157995008 19:13:35 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | Cycle 1(1): loaded http://localhost:51567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51567/tests/kraken/driver.html?testName=ai-astar) 19:13:37 INFO - PROCESS | 7796 | RSS: Main: 158732288 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | __start_tp_report 19:13:37 INFO - PROCESS | 7796 | _x_x_mozilla_page_load 19:13:37 INFO - PROCESS | 7796 | _x_x_mozilla_page_load_details 19:13:37 INFO - PROCESS | 7796 | |i|pagename|runs| 19:13:37 INFO - PROCESS | 7796 | |0;ai-astar;101;112;105;110;111;111;109;110;109;111 19:13:37 INFO - PROCESS | 7796 | |1;audio-beat-detection;142;117;144;177;126;142;141;117;182;115 19:13:37 INFO - PROCESS | 7796 | |2;audio-dft;161;165;163;162;163;161;162;162;161;163 19:13:37 INFO - PROCESS | 7796 | |3;audio-fft;75;75;76;180;75;77;74;77;169;76 19:13:37 INFO - PROCESS | 7796 | |4;audio-oscillator;84;83;155;84;83;83;142;84;84;157 19:13:37 INFO - PROCESS | 7796 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;117;119;118 19:13:37 INFO - PROCESS | 7796 | |6;imaging-darkroom;148;148;147;146;146;148;147;148;147;147 19:13:37 INFO - PROCESS | 7796 | |7;imaging-desaturate;95;95;95;95;96;95;95;96;96;96 19:13:37 INFO - PROCESS | 7796 | |8;json-parse-financial;51;51;51;51;51;51;53;51;52;51 19:13:37 INFO - PROCESS | 7796 | |9;json-stringify-tinderbox;59;59;60;59;59;59;59;59;58;59 19:13:37 INFO - PROCESS | 7796 | |10;stanford-crypto-aes;72;72;72;73;73;77;75;72;73;73 19:13:37 INFO - PROCESS | 7796 | |11;stanford-crypto-ccm;124;121;121;124;127;125;116;120;156;130 19:13:37 INFO - PROCESS | 7796 | |12;stanford-crypto-pbkdf2;157;153;157;152;152;157;153;150;156;154 19:13:37 INFO - PROCESS | 7796 | |13;stanford-crypto-sha256-iterative;65;62;63;64;62;67;62;63;62;60 19:13:37 INFO - PROCESS | 7796 | __end_tp_report 19:13:37 INFO - PROCESS | 7796 | __start_cc_report 19:13:37 INFO - PROCESS | 7796 | _x_x_mozilla_cycle_collect,878 19:13:37 INFO - PROCESS | 7796 | __end_cc_report 19:13:37 INFO - PROCESS | 7796 | __startTimestamp1472868817371__endTimestamp 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | ------- Summary: start ------- 19:13:37 INFO - PROCESS | 7796 | Number of tests: 14 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.38 (3.1%) stddev-sans-first:2.05 19:13:37 INFO - PROCESS | 7796 | Values: 101.0 112.0 105.0 110.0 111.0 111.0 109.0 110.0 109.0 111.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:142.00 stddev:23.66 (16.7%) stddev-sans-first:25.08 19:13:37 INFO - PROCESS | 7796 | Values: 142.0 117.0 144.0 177.0 126.0 142.0 141.0 117.0 182.0 115.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 19:13:37 INFO - PROCESS | 7796 | Values: 161.0 165.0 163.0 162.0 163.0 161.0 162.0 162.0 161.0 163.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:41.78 (55.3%) stddev-sans-first:43.66 19:13:37 INFO - PROCESS | 7796 | Values: 75.0 75.0 76.0 180.0 75.0 77.0 74.0 77.0 169.0 76.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:83.50 stddev:32.96 (39.5%) stddev-sans-first:34.16 19:13:37 INFO - PROCESS | 7796 | Values: 84.0 83.0 155.0 84.0 83.0 83.0 142.0 84.0 84.0 157.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 19:13:37 INFO - PROCESS | 7796 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 119.0 118.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 19:13:37 INFO - PROCESS | 7796 | Values: 148.0 148.0 147.0 146.0 146.0 148.0 147.0 148.0 147.0 147.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:13:37 INFO - PROCESS | 7796 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 19:13:37 INFO - PROCESS | 7796 | Values: 51.0 51.0 51.0 51.0 51.0 51.0 53.0 51.0 52.0 51.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 19:13:37 INFO - PROCESS | 7796 | Values: 59.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:1.62 (2.2%) stddev-sans-first:1.66 19:13:37 INFO - PROCESS | 7796 | Values: 72.0 72.0 72.0 73.0 73.0 77.0 75.0 72.0 73.0 73.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:124.50 stddev:11.11 (8.9%) stddev-sans-first:11.75 19:13:37 INFO - PROCESS | 7796 | Values: 124.0 121.0 121.0 124.0 127.0 125.0 116.0 120.0 156.0 130.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.10 Median:155.00 stddev:2.51 (1.6%) stddev-sans-first:2.44 19:13:37 INFO - PROCESS | 7796 | Values: 157.0 153.0 157.0 152.0 152.0 157.0 153.0 150.0 156.0 154.0 19:13:37 INFO - PROCESS | 7796 | 19:13:37 INFO - PROCESS | 7796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.94 (3.1%) stddev-sans-first:1.92 19:13:37 INFO - PROCESS | 7796 | Values: 65.0 62.0 63.0 64.0 62.0 67.0 62.0 63.0 62.0 60.0 19:13:37 INFO - PROCESS | 7796 | -------- Summary: end -------- 19:13:37 INFO - PROCESS | 7796 | 19:13:38 INFO - TEST-INFO | 7796: exit 0 19:13:38 INFO - TEST-OK | kraken | took 61114ms 19:13:38 INFO - SUITE-END | took 1172s 19:13:38 INFO - Completed test suite (00:19:32) 19:13:38 INFO - javascript benchmark 19:13:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7723.100253043848, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3258.2831777009055, 3279.376918385505, 3279.7048265656094, 3300.3729291434643, 3302.9669703302975, 5700.059490184115, 5784.334801497829, 5785.074388097905, 5806.0, 5806.361300256968, 5772.855678608037, 5820.272465941757, 5836.949349117168, 5843.79546715865, 5846.6199697019665, 5237.502437268472, 5267.473252674721, 5288.762005709733, 5308.5487733542695, 5314.0, 5161.380634323887, 5185.714785686786, 5185.792568297264, 5200.947990520084, 5209.453007434222, 5189.584833213353, 5194.454582268864, 5203.713795741232, 5206.505381988705, 5245.134552798783, 5185.144451165553, 5233.084210263208, 5238.266642670029, 5243.10867152585, 5259.86850328741, 4998.750062496861, 5075.0, 5083.872903177413, 5113.872153196163, 5144.922826157611, 5643.238162848045, 5692.089265717506, 5699.373068962411, 5705.77176912923, 5715.828525144252, 6118.632882027093, 6119.112728654365, 6121.938780612181, 6138.294096178907, 6158.507319414436, 5947.791827286068, 6097.57316987811, 6110.083487476914, 6128.0, 6135.018317212185, 5767.682777447197, 5797.826065218051, 5805.158252053471, 5832.854178645568, 5839.328477225088, 6294.9685251574365, 6302.369763023753, 6345.04824276353, 6350.110984462179, 6366.236051673829, 5928.970355148197, 5953.583249172603, 5978.28260608721, 5998.610090344201, 6072.90890636632, 6129.725578588854, 6134.9079763803575, 6142.464383904024, 6144.969275153685, 6146.0473626587955, 6072.635641861502, 6079.331273559905, 6117.602355846856, 6135.723892424851, 6151.692415379213, 5917.852053698692, 6116.969415152896, 6120.540959427972, 6127.433875357673, 6142.877142457126, 4742.478327383985, 4757.976210118927, 4758.2386818108935, 4759.048190361941, 4770.260609605517, 4210.599993000721, 4235.068284977362, 4236.745795252295, 4245.214635292481, 4248.660107191417, 5697.202391665171, 5831.358550559435, 5832.88334233313, 5847.210626565445, 5954.19618351517, 6195.721192546346, 6200.751969921243, 6202.627842329474, 6209.472194863397, 6224.782132625336, 5922.970385148046, 5935.109733539917, 5951.345352011275, 5958.6424814511265, 6004.219451471368, 5138.768755406016, 5219.556337711261, 5242.0302244084205, 5248.3701955765555, 5318.521333080042, 6342.334054924258, 6342.714577844008, 6344.175257216532, 6344.968275158687, 6352.936470635234, 6093.9085913712215, 6127.724252408741, 6136.570440069331, 6148.0, 6156.415140561639, 6245.469135123565, 6287.685615719104, 6322.589031712924, 6345.238571371465, 6346.238451385863, 6120.508083830795, 6128.353235766433, 6128.903521899524, 6130.398136741914, 6140.04415716754, 6195.535334849814, 6196.752129914933, 6241.251049874044, 6251.749930002749, 6257.342978987323, 5824.767009319579, 5973.462388385066, 5974.40255974399, 6009.669468179292, 6074.36219196978, 6085.087236914321, 6090.665013424305, 6092.786752463642, 6097.878042439215, 6113.14415981754, 5986.9401305986385, 5988.700564971647, 6040.939590604214, 6050.0, 6061.393860613904, 5802.796902108406, 6021.42796434338, 6033.909491357545, 6041.18444010053, 6056.515478761777, 5946.197263369563, 5951.821445356646, 5964.522838172849, 5975.312839023568, 5985.102234664835], "value": 5672.170211702707, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.552312940097, 601.3925934805847, 616.9198004259446, 667.8063361625129, 696.7665831946298, 40644.39033414498, 45135.0, 45194.548054519444, 45355.77322113385, 45384.31923521146, 45204.32193517092, 45503.54496455035, 45678.54321456784, 45823.77088114563, 45845.770771146184, 8921.553922303876, 9116.088391160863, 9159.313051521129, 9162.72511824643, 9187.816243675123, 8769.868451973225, 8781.912180878206, 8809.603567839431, 8815.294776417903, 8859.734207973772, 8783.780405489882, 8815.294776417872, 8876.644934202624, 8889.599968001423, 8892.421992570495, 9085.909140908605, 9093.40892841963, 9105.590248438803, 9115.0, 9116.908830911738, 8850.468971861708, 8875.156860098281, 8919.42023768453, 8948.55257237142, 8971.372003959725, 43690.56309436897, 44211.0, 44368.0, 44444.0, 44462.11075778466, 3687.6865466435383, 3702.740808143431, 3844.596317386662, 3848.3265428549894, 3902.7853468059247, 35002.0, 35149.82425087884, 35405.82297088498, 35845.92462226137, 35963.82018089919, 4780.306855505932, 4799.352087468217, 4831.975840120777, 4857.34425852509, 4934.432540257881, 371636.0, 375690.0, 376298.0, 377682.0, 377782.0, 66158.33841661522, 66206.0, 66447.66776166185, 66484.33515664781, 66562.66718666472, 33123.66876331206, 33306.0, 33754.66245337564, 34823.30353392918, 34921.0, 15941.601459963595, 16111.113888736232, 16161.757573636405, 16190.0, 16221.35114595403, 11957.103217258566, 11989.520419183134, 12025.759484810254, 12032.157748957488, 12070.879291207151, 20356.69464958027, 21025.684614730486, 21030.684539731916, 21102.683459748117, 21210.575788484453, 7336.449766267551, 7491.887621685679, 7714.498557593738, 7716.6527506262355, 7778.105517865405, 1067.7330667333167, 1079.3092420850662, 1082.7888561730545, 1146.1919346860443, 1199.196538319328, 33433.83283083569, 34624.82687586546, 37401.0, 37613.059673507836, 37643.24713505714, 1129.4239937631703, 1152.181950814914, 1203.169812829145, 1204.8313236146946, 1250.6435665835193, 16979.830201697823, 17183.828161718473, 17186.31254749796, 17367.739483907753, 17712.734308985375, 434044.0, 613824.0, 619028.0, 621457.0, 624802.0, 65002.34997649963, 65100.67449662816, 65401.67299163474, 65431.67284163549, 65526.34473655298, 1442.3365251984205, 1461.2547600723708, 1485.9405623774928, 1490.4336352186099, 1500.46733409638, 33789.0, 34196.316073678885, 34320.0, 34778.652213477544, 34827.65172348244, 54213.18680219879, 54669.453305466435, 54829.72585137049, 54843.45156548383, 54846.17730734122, 517470.0, 518691.0, 520762.0, 521601.0, 523978.0, 29671.0, 30128.0, 30201.244968875075, 30515.2371190722, 30575.08274751761, 51011.30991562426, 51962.740186298826, 52363.73818130885, 52453.7377313111, 52529.737351313, 42254.78872605618, 42526.36210456784, 43625.78187109171, 44343.77828110839, 44870.551294486635, 42159.578404215565, 43494.78252608717, 44018.119637607706, 44127.0, 44376.0, 39025.41461878131, 39626.2074758509, 39650.60349396469, 41629.167416652104, 41814.79092604518, 37030.0, 37856.810715946245, 38106.23787524289, 38787.80606096952, 39024.80487597544, 29039.709602903702, 29313.56029659514, 29551.0, 29667.406651867273, 29698.406031879673], "value": 20910.655915330113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3800870641801, 398.9421533877586, 403.7496752013751, 407.8022159252762, 417.5407052242534, 15128.470503532351, 18180.181891814867, 19473.221071157153, 19643.901780491076, 20289.391318260437, 20534.38396848093, 20744.792552074512, 21134.365969020917, 21193.152273909065, 21272.0, 5705.914411283834, 5872.060470324749, 5933.910991335133, 5948.940510594904, 5973.074173503114, 5985.371535988724, 5992.610480318787, 6041.093835924603, 6042.969785151068, 6105.450509454148, 5683.204351390808, 5976.73104710289, 6055.455009049185, 6061.090836374535, 6072.969635151818, 5656.773729050833, 5670.546356291507, 5763.279590051244, 5785.681787501686, 5796.13058041293, 5274.709890955995, 5417.133258678593, 5421.969825733098, 5434.7826086956475, 5440.591955603346, 19999.700004499944, 24929.252122436355, 25516.74483255181, 25601.103961361263, 25661.74338256612, 2621.423286876884, 2630.237231202949, 2646.3913299941123, 2885.639295088114, 3236.1100697308193, 10456.634017809416, 10742.248042637018, 10961.945190273998, 16044.117573533567, 16178.595535111599, 1948.3570421760926, 2009.336918816787, 2011.4669612552684, 2050.7231523744404, 2080.4278823323557, 75700.99999999945, 82690.17309826885, 85532.57233713854, 86880.0, 87599.0, 10607.522661480252, 11014.44927753609, 11051.392173430539, 11178.664640060812, 11386.601468948713, 15814.76277855833, 15855.762163567555, 15865.127417991891, 15866.761998570031, 15903.0, 8008.159143289987, 8213.219744124299, 8277.503349799032, 8408.873866892001, 8436.662533498591, 7880.408969327324, 7894.407919406068, 7941.166177551389, 8003.119656837744, 8083.757487275391, 4739.049208999093, 4807.158747219222, 4887.875788568649, 4890.364252647133, 4977.601791856643, 1941.7475728155262, 1999.152056263555, 2013.788552202027, 2031.4007367826528, 2048.365006847882, 931.4783721116197, 986.1124987511154, 1028.665683652816, 1048.7692707604315, 1068.5779117248644, 20041.599168016557, 20908.0, 20918.477038073866, 21171.68242476364, 21233.150673973178, 1048.2924026282228, 1096.855746548684, 1109.14595761265, 1118.959367787965, 1120.2270433400927, 11018.889811101786, 11181.664550063511, 11252.49363778632, 11781.0, 11805.0, 517851.0, 524383.0, 525532.0, 526137.0, 536782.0, 59317.703411483526, 77136.61431692805, 97248.51375743076, 99693.50153249332, 100626.49686751666, 1033.503918119292, 1049.5434485998462, 1064.7551063255494, 1071.3036526257995, 1074.2533938912536, 18149.27402903869, 18665.6266874659, 18949.95529492851, 19004.14481348315, 19237.0, 34345.82827085849, 43858.342124867515, 44338.334924975505, 44532.554674454135, 45889.31166032579, 58763.412365877506, 60323.0, 60684.393156069644, 62208.06687899776, 69505.30494694988, 8787.5166865823, 8916.55417229149, 8979.595918183828, 9022.86465703028, 9143.177114059767, 11737.0, 13870.167789932637, 13873.930630346784, 13908.0, 14390.208538530482, 12247.632571022883, 12547.811782823082, 12565.120441569003, 12799.42402591867, 12842.67893302675, 11937.701557461132, 12277.75444491123, 12373.381330933238, 12421.0, 12441.440135193758, 12668.619941401772, 12846.743065138831, 12869.0, 12929.0, 13025.674358141123, 8688.565571721263, 8816.603252853509, 8911.598978046133, 9097.1812536872, 9130.589123489592, 9011.324150688593, 11563.6530904073, 12092.939535302266, 12145.332006739714, 12327.075469339656], "value": 9647.152396727595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.889424398926, 1326.5091915991084, 1454.919979401133, 1843.7510936023632, 1872.1762424533197, 8447.831043379128, 9081.954590227047, 9110.316726245524, 9736.610535578586, 9767.072128147824, 9210.631574737003, 9505.762355941104, 9510.524473776319, 9514.42913425195, 9521.857172142423, 2454.4968281502292, 2472.6167444046114, 2489.539435204484, 2491.364702000987, 2494.837835540693, 2437.914672986446, 2524.4951009798115, 2526.431552900601, 2526.6589010483626, 2536.2898388451263, 2482.391814005571, 2491.364702000996, 2531.493701259755, 2537.2768760903145, 2540.0220914947695, 2469.937926691522, 2471.752824717541, 2475.170817776047, 2490.7882829959476, 2496.6255061740703, 2442.3161514775893, 2449.6815413996246, 2470.1848390031246, 2481.1564068216894, 2482.925512234636, 9472.336936414455, 9533.380330278578, 9645.614175432975, 9656.27577931658, 9673.129418352382, 5596.888062238732, 5677.971610141964, 5683.232763576947, 5686.488216060575, 5717.171010203539, 3529.7882127072457, 3554.875579354736, 3584.956574752392, 3639.344917914774, 3647.598764135943, 1183.1185766603935, 1193.0813273779142, 1211.3095535544744, 1228.4901765767195, 1247.1145486704452, 12959.805602915963, 12989.090763646549, 12994.545190918272, 13010.674733131653, 13026.54407095747, 4902.313676085351, 4968.329275547755, 5009.24861270805, 5055.115354812893, 5059.696418214919, 10807.027367536803, 10824.15989281824, 10836.187285953585, 10882.782344353069, 10923.617673381394, 5724.427557244242, 5735.254416925773, 5752.913706294409, 5757.884842303214, 5769.048107062287, 4658.720476771405, 5106.285120083191, 5216.1393370094265, 5245.10833158364, 5288.444713305047, 4177.6866734995, 4258.467691538558, 4310.181065597527, 4330.047389574289, 4363.869083927487, 1317.8879795217515, 1321.3459337627935, 1338.3375229261578, 1341.9194848309132, 1343.0464370297002, 925.8287216864901, 968.4721826604376, 1048.3971716263027, 1060.48566445274, 1061.6178175856685, 6438.25960014595, 6497.090407342881, 6515.934840651627, 6589.110470086573, 6703.966480167568, 494.90101979604225, 508.6464906889676, 509.05062059259217, 511.15148852904, 513.8304359561336, 4547.727136371828, 4576.794044268016, 4613.446386433649, 4653.95346046542, 4670.439547254351, 11376.943115284535, 11840.70398240051, 11909.523619055313, 11932.582359617372, 11952.282863028246, 11157.442127893573, 11651.825222621668, 11684.415779211175, 11859.822102668468, 11934.462949167135, 8701.30389568833, 8849.070847560914, 8857.291416686778, 8861.24679402245, 8885.333599980027, 6638.20341559016, 6802.965985170043, 6849.828754281183, 6918.481113916376, 6923.653817309215, 10789.190810689386, 10921.78156436851, 10940.0, 10954.452277385939, 10963.287386319864, 11023.944880275869, 11062.22564420483, 11070.0, 11157.609483668033, 11262.38056906878, 7772.261635144652, 8596.269317108116, 8599.871001934851, 8714.477131371885, 8907.554622268732, 8947.150020748019, 9154.816903662022, 9162.816743665222, 9174.816503669756, 9226.584803683716, 7904.367650587824, 8139.267465927858, 8154.1030486647605, 8228.136045715113, 8263.793405164919, 7871.212878712312, 8107.594620268845, 8170.305524030524, 8211.917880821115, 8346.540940248344, 7474.962625186839, 7488.063992001, 7531.3598344141365, 7541.585212813348, 7614.200508946481, 5640.971795141162, 5720.2849643794525, 5739.684317362585, 5774.307083150049, 5816.854578635568, 5617.185508101385, 5695.373508913934, 5748.856278592902, 5774.1338799178775, 5960.791372301948], "value": 4905.995488411239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6048544174199, 349.8548102537447, 350.7755036776463, 358.2744941493477, 358.5160033954161, 5770.3364113127, 5832.941670583298, 5884.941150588504, 5900.822975310743, 5920.733566989485, 5722.685252311121, 5728.971355143229, 5761.300416377168, 5762.3949485303965, 5781.595288329808, 4285.742855428676, 4444.866654000385, 4484.843030493933, 4492.213862574053, 4519.864404067883, 4465.771912724011, 4498.820047198108, 4501.414816073906, 4518.43519560055, 4546.47715512717, 4461.83992162037, 4496.168208881351, 4506.864794056183, 4519.5932366087045, 4536.9773151134195, 4409.647228221735, 4432.135733531963, 4446.133004064209, 4447.444069491314, 4458.576435238663, 3946.980265098656, 3958.5843486433796, 3964.2953529982096, 3968.7023473239333, 3986.461827653288, 5605.0, 5638.661680299195, 5639.984802735506, 5658.321001479849, 5661.575381846378, 5070.163423035195, 5081.577158395655, 5132.769025393866, 5143.614228932845, 5169.508896654812, 5952.494038006731, 6008.519318454513, 6017.398260173992, 6025.216721826178, 6047.365026672224, 4306.26793445112, 4329.502107257674, 4358.978205108954, 4384.057427653038, 4386.670999675005, 6013.338532761437, 6016.879662406771, 6112.144299798077, 6246.15676883624, 6253.499160201564, 4369.890752731207, 4372.23485889968, 4411.845585404495, 4413.7793110345, 4418.298954902386, 4465.307877279027, 4472.664550158751, 4475.7985890634345, 4481.731096134177, 4492.05666809967, 4944.431390390079, 5025.47232540578, 5128.743562821844, 5139.12634852076, 5148.948510514847, 5989.562504998769, 6002.639841609517, 6040.546958978094, 6080.14877917092, 6109.419605137505, 1508.1780429665857, 1525.2297589717123, 1530.7856900034003, 1546.6983938132182, 1550.4573399310152, 989.4310771306527, 1032.7573020340214, 1036.5540071600076, 1048.5910494906993, 1059.6979860739652, 5151.866589350337, 5195.870103247449, 5198.376194856642, 5203.531682148625, 5266.605004624668, 5431.646942948775, 5467.906418716273, 5549.448353054048, 5561.888762224733, 5588.804391846266, 4981.708414129468, 5222.216667499905, 5241.663375839136, 5312.9734351328, 5350.384705758887, 2920.269932516871, 2945.7038902882664, 2952.4980753271993, 2973.6728959814404, 2990.220818612922, 5639.0, 5680.943190568041, 5713.457221563945, 5723.855228954226, 5735.311762588516, 5959.404059594006, 6414.518911081687, 6444.516661250425, 6444.903326450013, 6465.0, 6525.282218955911, 6534.607923524603, 6584.473242140617, 6608.207015158212, 6641.767538136142, 6136.2636483622255, 6257.624542527463, 6329.177206963065, 6341.365863413622, 6383.904241436475, 6261.24865016201, 6271.153394291712, 6337.0, 6342.460890824332, 6367.490600752021, 6256.562040657111, 6372.58578192416, 6432.195975503062, 6433.616772393958, 6485.189351331083, 4366.235908716026, 4401.515833258275, 4418.293073108287, 4424.690271680952, 4436.977815110904, 6242.7838117467645, 6291.653959032297, 6321.431071203614, 6354.332795056453, 6407.327230640902, 6080.543959203166, 6081.543884208791, 6092.634441933498, 6092.8781424372155, 6175.876482470415, 5903.498202652822, 6120.0, 6133.172021777182, 6136.189824001841, 6173.197484327009, 5912.763489460545, 5935.198748168942, 5981.700914954322, 6004.42957918997, 6012.398760123952, 6067.908981365194, 6085.939140608537, 6096.908546371897, 6099.420555047441, 6152.169457123231, 5806.7225210453635, 5936.1986131871645, 5977.0, 5977.581569290108, 5981.222441082631], "value": 4553.932522057052, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.8556659801241, 802.546561192926, 813.6745301879248, 819.1808191808192, 852.9829403411932, 15481.303341349638, 17065.232064557094, 17324.393646222386, 17331.133443327846, 17360.218790154442, 16003.919980400082, 16130.274137663804, 16259.105749183791, 16267.51197464078, 16311.59221019475, 720.6108701301291, 862.8403745307107, 867.4621734524573, 871.5816408124105, 873.2620935309685, 877.473515890467, 878.5431575580726, 881.6120906801019, 886.0120965123873, 887.8002449448887, 924.9213816825578, 931.6739141300525, 933.7712260496154, 934.0612684252351, 939.0515579264958, 930.9487978161164, 932.4405356785942, 934.9532523373838, 937.6015193542751, 939.5349302095507, 690.9136357955256, 692.1935944624506, 692.5706062241443, 693.2616763147232, 694.6908625661582, 15516.689666206612, 15556.299966501534, 15581.688366232725, 15583.532494025198, 15592.37630494779, 13767.449302027906, 14672.486462973744, 14957.70084598302, 15371.0, 15500.457483988006, 14401.423943042266, 14809.185494797783, 15095.622609434742, 15126.394944202219, 15166.848331516654, 5001.724905130252, 5009.674371165899, 5025.924611130836, 5110.10573149701, 5149.30484384607, 82286.58856705738, 82319.17680823174, 83961.58019209864, 85432.57283713603, 91523.0, 12606.495740170474, 12687.238765674088, 12854.678633034062, 12959.287239201934, 13191.208527488381, 21733.456663583536, 21780.78219217819, 21986.780132198473, 22044.779552204593, 22906.65640015401, 9276.35065545419, 9832.213422926148, 9855.852162217572, 10008.799824003625, 10031.799364012824, 5294.682319060868, 5372.140457526855, 5402.324709411324, 5450.8909821803345, 5501.504864562208, 4006.098627808778, 4114.259433302034, 4155.148194620096, 4158.209940111369, 4187.78554219273, 712.3553184368155, 715.7045747197485, 723.9710411583583, 727.8398752274597, 735.8344372516248, 697.5465947134403, 744.7318965172534, 762.7406681728239, 833.7790485521342, 843.8270154618289, 10356.533955972, 10726.892731072745, 10861.891381086247, 11014.339139651647, 11549.538018479167, 705.1608585783005, 748.8389996150745, 756.9659365328573, 794.1581923161467, 802.9076656184614, 5127.974360128175, 5390.029794636925, 5421.680780468432, 5483.204935284361, 5488.506034456918, 73821.0, 75069.24930750622, 75405.62297188479, 98305.0, 120953.79046209426, 113925.0, 114853.0, 116113.0, 116253.41873290579, 119553.0, 65387.0, 93001.0, 93714.82129592162, 100471.0, 103493.48253258686, 10073.093421592092, 10181.287309888534, 10250.0, 10329.741756455847, 10405.167586592903, 48890.0, 49036.509634903196, 59404.0, 60858.39141608704, 62617.37382626298, 50293.74853125857, 54201.728991354794, 76599.61700191464, 77169.2283077162, 77755.0, 13424.798628020391, 14037.578872633838, 14084.436622534984, 14236.145831250158, 14236.359363828446, 16437.342506299614, 16439.424620138238, 16463.34146634169, 16646.583835404213, 16858.831411686217, 14690.926545367205, 14857.257137142884, 15346.0, 15636.140012299433, 16166.0, 14998.2500874958, 15067.0, 15364.769528457306, 15630.765538517158, 16271.837281627033, 14487.92756036213, 14590.781138282722, 14614.780778288547, 15129.546113616609, 15404.537863864101, 12359.752804943671, 12934.417951192407, 13077.542286019943, 13208.471661133832, 13686.110402823784, 13163.276019818619, 13500.5274815381, 13525.323733813466, 13566.0, 13582.53532045594], "value": 8300.019089138397, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 105.0, 110.0, 111.0, 111.0, 109.0, 110.0, 109.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 144.0, 177.0, 126.0, 142.0, 141.0, 117.0, 182.0, 115.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 163.0, 162.0, 163.0, 161.0, 162.0, 162.0, 161.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 180.0, 75.0, 77.0, 74.0, 77.0, 169.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 155.0, 84.0, 83.0, 83.0, 142.0, 84.0, 84.0, 157.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 146.0, 146.0, 148.0, 147.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 53.0, 51.0, 52.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 73.0, 77.0, 75.0, 72.0, 73.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 121.0, 124.0, 127.0, 125.0, 116.0, 120.0, 156.0, 130.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 157.0, 152.0, 152.0, 157.0, 153.0, 150.0, 156.0, 154.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 64.0, 62.0, 67.0, 62.0, 63.0, 62.0, 60.0], "value": 63.0, "unit": "score"}]}]} 19:13:38 INFO - Return code: 0 19:13:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:13:38 ERROR - # TBPL SUCCESS # 19:13:38 INFO - Running post-action listener: _resource_record_post_action 19:13:38 INFO - [mozharness: 2016-09-03 02:13:38.704966Z] Finished run-tests step (success) 19:13:38 INFO - Running post-run listener: _resource_record_post_run 19:13:38 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328757248; Read time: 28; Write time: 353712 19:13:38 INFO - TinderboxPrint: CPU usage
13.2% 19:13:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 19:13:38 INFO - TinderboxPrint: I/O write bytes / time
328,757,248 / 353,712 19:13:38 INFO - TinderboxPrint: CPU idle
8,236.1 (86.7%) 19:13:38 INFO - TinderboxPrint: CPU user
1,201.2 (12.7%) 19:13:38 INFO - TinderboxPrint: Swap in / out
0 / 0 19:13:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78696448; Read time: 0; Write time: 117440 19:13:38 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 249446400; Read time: 0; Write time: 236272 19:13:39 INFO - Running post-run listener: _upload_blobber_files 19:13:39 INFO - Blob upload gear active. 19:13:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:13:39 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 19:13:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:13:39 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:43 INFO - (blobuploader) - INFO - Done attempting. 19:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:13:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:44 INFO - (blobuploader) - INFO - Done attempting. 19:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:13:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:44 INFO - (blobuploader) - INFO - Done attempting. 19:13:44 INFO - (blobuploader) - INFO - Iteration through files over. 19:13:45 INFO - Return code: 0 19:13:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:13:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:13:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9659424ec01c176ba6143a90c7a0109475482f94645b98f0be1cb4ae6795b2e60f24e131b6b7adbcd99708551b776c22c002221bcac9c41de5152cd2048aa10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c2887ad0c90a96b4eca055305b23bb2468819dbe2d1bdcb8f46e333889cef239694816cb17cce09d675a95af9833b05705f606fa175d442ca4ca50d15920d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063a60dfea468152acad20008233b5b79fabe23e79ad1e996264c2c47ae2a00050c7d384b0138303039ff40cbbc5bffaa7ca5e47411c152ca9b1f7cabf01de81"} 19:13:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:13:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:13:45 INFO - Contents: 19:13:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9659424ec01c176ba6143a90c7a0109475482f94645b98f0be1cb4ae6795b2e60f24e131b6b7adbcd99708551b776c22c002221bcac9c41de5152cd2048aa10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c2887ad0c90a96b4eca055305b23bb2468819dbe2d1bdcb8f46e333889cef239694816cb17cce09d675a95af9833b05705f606fa175d442ca4ca50d15920d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063a60dfea468152acad20008233b5b79fabe23e79ad1e996264c2c47ae2a00050c7d384b0138303039ff40cbbc5bffaa7ca5e47411c152ca9b1f7cabf01de81"} 19:13:45 INFO - Running post-run listener: copy_logs_to_upload_dir 19:13:45 INFO - Copying logs to upload dir... 19:13:45 INFO - mkdir: /builds/slave/test/build/upload/logs 19:13:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.932968 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-09-02 19:13:44.513793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 19:13:44.517513) ========= 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=32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9659424ec01c176ba6143a90c7a0109475482f94645b98f0be1cb4ae6795b2e60f24e131b6b7adbcd99708551b776c22c002221bcac9c41de5152cd2048aa10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c2887ad0c90a96b4eca055305b23bb2468819dbe2d1bdcb8f46e333889cef239694816cb17cce09d675a95af9833b05705f606fa175d442ca4ca50d15920d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063a60dfea468152acad20008233b5b79fabe23e79ad1e996264c2c47ae2a00050c7d384b0138303039ff40cbbc5bffaa7ca5e47411c152ca9b1f7cabf01de81"} build_url:https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9659424ec01c176ba6143a90c7a0109475482f94645b98f0be1cb4ae6795b2e60f24e131b6b7adbcd99708551b776c22c002221bcac9c41de5152cd2048aa10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c2887ad0c90a96b4eca055305b23bb2468819dbe2d1bdcb8f46e333889cef239694816cb17cce09d675a95af9833b05705f606fa175d442ca4ca50d15920d7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063a60dfea468152acad20008233b5b79fabe23e79ad1e996264c2c47ae2a00050c7d384b0138303039ff40cbbc5bffaa7ca5e47411c152ca9b1f7cabf01de81"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 19:13:44.543398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 19:13:44.543775) ========= 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=32c5991c409366f7fec8a718000001d2-1472866889.903500-1985131166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 19:13:44.628313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 19:13:44.628644) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 19:13:44.629099) ========= ========= Total master_lag: 0.32 =========