builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1473936267.18 results: success (0) buildid: 20160915004005 builduid: 9217f83682a34f50b81a1d13eec34767 revision: 9f8472060b5eaad0bc976f07b932981366a938dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.176005) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.176479) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.176808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.191331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.191624) ========= 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=cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-15 03:44:27-- 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% 226M=0s 2016-09-15 03:44:27 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.292667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.292977) ========= 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=cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018714 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:27.342213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-15 03:44:27.342556) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9f8472060b5eaad0bc976f07b932981366a938dd --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 9f8472060b5eaad0bc976f07b932981366a938dd --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=cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-15 03:44:27,492 truncating revision to first 12 chars 2016-09-15 03:44:27,492 Setting DEBUG logging. 2016-09-15 03:44:27,493 attempt 1/10 2016-09-15 03:44:27,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9f8472060b5e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-15 03:44:28,234 unpacking tar archive at: mozilla-aurora-9f8472060b5e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.092417 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-15 03:44:28.448083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:28.448410) ========= script_repo_revision: 9f8472060b5eaad0bc976f07b932981366a938dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:28.448845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:28.449120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-15 03:44:28.459356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-15 03:44:28.459663) ========= /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=cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:28 INFO - MultiFileLogger online at 20160915 03:44:28 in /builds/slave/test 03:44:28 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 03:44:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:28 INFO - {'append_to_log': False, 03:44:28 INFO - 'base_work_dir': '/builds/slave/test', 03:44:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:44:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:28 INFO - 'branch': 'Mozilla-Aurora', 03:44:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:28 INFO - 'config_files': ('talos/linux_config.py',), 03:44:28 INFO - 'default_actions': ('clobber', 03:44:28 INFO - 'read-buildbot-config', 03:44:28 INFO - 'download-and-extract', 03:44:28 INFO - 'populate-webroot', 03:44:28 INFO - 'create-virtualenv', 03:44:28 INFO - 'install', 03:44:28 INFO - 'run-tests'), 03:44:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:28 INFO - 'download_minidump_stackwalk': True, 03:44:28 INFO - 'download_symbols': 'ondemand', 03:44:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:28 INFO - 'installer_path': 'installer.exe', 03:44:28 INFO - 'log_level': 'info', 03:44:28 INFO - 'log_name': 'talos', 03:44:28 INFO - 'log_to_console': True, 03:44:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:28 INFO - 'opt_config_files': (), 03:44:28 INFO - 'pip_index': False, 03:44:28 INFO - 'sps_profile': False, 03:44:28 INFO - 'sps_profile_interval': 0, 03:44:28 INFO - 'suite': 'dromaeojs-e10s', 03:44:28 INFO - 'system_bits': '32', 03:44:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:28 INFO - 'title': 'talos-linux64-ix-054', 03:44:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:28 INFO - 'use_talos_json': True, 03:44:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:28 INFO - 'work_dir': 'build'} 03:44:28 INFO - [mozharness: 2016-09-15 10:44:28.705634Z] Running clobber step. 03:44:28 INFO - Running pre-action listener: _resource_record_pre_action 03:44:28 INFO - Running main action method: clobber 03:44:28 INFO - rmtree: /builds/slave/test/build 03:44:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:29 INFO - Running post-action listener: _resource_record_post_action 03:44:29 INFO - [mozharness: 2016-09-15 10:44:29.155201Z] Finished clobber step (success) 03:44:29 INFO - [mozharness: 2016-09-15 10:44:29.155301Z] Running read-buildbot-config step. 03:44:29 INFO - Running pre-action listener: _resource_record_pre_action 03:44:29 INFO - Running main action method: read_buildbot_config 03:44:29 INFO - Using buildbot properties: 03:44:29 INFO - { 03:44:29 INFO - "project": "", 03:44:29 INFO - "product": "firefox", 03:44:29 INFO - "script_repo_revision": "production", 03:44:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:44:29 INFO - "repository": "", 03:44:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:44:29 INFO - "buildid": "20160915004005", 03:44:29 INFO - "stage_platform": "linux64-pgo", 03:44:29 INFO - "basedir": "/builds/slave/test", 03:44:29 INFO - "nightly_build": "True", 03:44:29 INFO - "buildnumber": 554, 03:44:29 INFO - "slavename": "talos-linux64-ix-054", 03:44:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:44:29 INFO - "platform": "ubuntu64_hw", 03:44:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:44:29 INFO - "branch": "mozilla-aurora", 03:44:29 INFO - "repo_path": "releases/mozilla-aurora", 03:44:29 INFO - "revision": "9f8472060b5eaad0bc976f07b932981366a938dd", 03:44:29 INFO - "pgo_build": "True", 03:44:29 INFO - "builduid": "9217f83682a34f50b81a1d13eec34767", 03:44:29 INFO - "slavebuilddir": "test" 03:44:29 INFO - } 03:44:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:44:29 INFO - Running post-action listener: _resource_record_post_action 03:44:29 INFO - [mozharness: 2016-09-15 10:44:29.157805Z] Finished read-buildbot-config step (success) 03:44:29 INFO - [mozharness: 2016-09-15 10:44:29.157892Z] Running download-and-extract step. 03:44:29 INFO - Running pre-action listener: _resource_record_pre_action 03:44:29 INFO - Running main action method: download_and_extract 03:44:29 INFO - mkdir: /builds/slave/test/build/tests 03:44: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')]} 03:44:29 INFO - https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:44:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:44:29 INFO - retry: Failed, sleeping 30 seconds before retrying 03:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:44:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:44:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:44:59 INFO - retry: Failed, sleeping 60 seconds before retrying 03:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:45:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:45:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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! 03:45:59 INFO - Caught exception: HTTP Error 404: Not Found 03:45:59 INFO - Caught exception: HTTP Error 404: Not Found 03:45:59 INFO - Caught exception: HTTP Error 404: Not Found 03:45:59 INFO - trying https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:45:59 INFO - Downloaded 1361 bytes. 03:45:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:45:59 INFO - Using the following test package requirements: 03:45:59 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:59 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:45:59 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:45:59 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'jsshell-linux-x86_64.zip'], 03:45:59 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:45:59 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:59 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:45:59 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:45:59 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:45:59 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:59 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:45:59 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:45:59 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')]} 03:45:59 INFO - https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:45:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:45:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:45:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:45:59 INFO - retry: Failed, sleeping 30 seconds before retrying 03:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:46:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:46:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:46:29 INFO - retry: Failed, sleeping 60 seconds before retrying 03:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:47:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:47:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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! 03:47:30 INFO - Caught exception: HTTP Error 404: Not Found 03:47:30 INFO - Caught exception: HTTP Error 404: Not Found 03:47:30 INFO - Caught exception: HTTP Error 404: Not Found 03:47:30 INFO - trying https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:47:30 INFO - Downloaded 21771390 bytes. 03:47:30 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'] 03:47:30 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 03:47:31 INFO - Return code: 0 03:47:32 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 03:47: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')]} 03:47:32 INFO - https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:47:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:47:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:47:32 INFO - retry: Failed, sleeping 30 seconds before retrying 03:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:48:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:48:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:48:02 INFO - retry: Failed, sleeping 60 seconds before retrying 03:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:49:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:49:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:49:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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! 03:49:02 INFO - Caught exception: HTTP Error 404: Not Found 03:49:02 INFO - Caught exception: HTTP Error 404: Not Found 03:49:02 INFO - Caught exception: HTTP Error 404: Not Found 03:49:02 INFO - trying https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:49:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:49:03 INFO - Downloaded 21771390 bytes. 03:49:03 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'] 03:49:03 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 03:49:04 INFO - Return code: 0 03:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:04 INFO - https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:49:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:49:04 INFO - retry: Failed, sleeping 30 seconds before retrying 03:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:49:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:49:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:49:34 INFO - retry: Failed, sleeping 60 seconds before retrying 03:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:50:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:50:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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! 03:50:34 INFO - Caught exception: HTTP Error 404: Not Found 03:50:34 INFO - Caught exception: HTTP Error 404: Not Found 03:50:34 INFO - Caught exception: HTTP Error 404: Not Found 03:50:34 INFO - trying https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:50:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:50:35 INFO - Downloaded 14413740 bytes. 03:50:35 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'] 03:50:35 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 03:50:35 INFO - Return code: 0 03:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:35 INFO - https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:50:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:50:35 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:50:35 INFO - retry: Failed, sleeping 30 seconds before retrying 03:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:51:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:51:05 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:51:05 INFO - retry: Failed, sleeping 60 seconds before retrying 03:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:52:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:05 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:52:05 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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! 03:52:05 INFO - Caught exception: HTTP Error 404: Not Found 03:52:05 INFO - Caught exception: HTTP Error 404: Not Found 03:52:05 INFO - Caught exception: HTTP Error 404: Not Found 03:52:05 INFO - trying https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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 03:52:06 INFO - Downloaded 63868666 bytes. 03:52:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:06 INFO - mkdir: /builds/slave/test/properties 03:52:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:06 INFO - Contents: 03:52:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:52:07 INFO - Running post-action listener: _resource_record_post_action 03:52:07 INFO - Running post-action listener: set_extra_try_arguments 03:52:07 INFO - [mozharness: 2016-09-15 10:52:07.451011Z] Finished download-and-extract step (success) 03:52:07 INFO - [mozharness: 2016-09-15 10:52:07.451242Z] Running populate-webroot step. 03:52:07 INFO - Running pre-action listener: _resource_record_pre_action 03:52:07 INFO - Running main action method: populate_webroot 03:52:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:07 INFO - '--tppagecycles', 03:52:07 INFO - '7'], 03:52:07 INFO - 'tests': ['tsvgm']}}, 03:52:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['damp', 'tps']}, 03:52:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'tests': ['damp', 'tps']}, 03:52:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['dromaeo_dom']}, 03:52:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['basic_compositor_video']}, 03:52:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:52:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['a11yr', 03:52:07 INFO - 'ts_paint', 03:52:07 INFO - 'tpaint', 03:52:07 INFO - 'sessionrestore', 03:52:07 INFO - 'sessionrestore_no_auto_restore', 03:52:07 INFO - 'tabpaint']}, 03:52:07 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:07 INFO - 'ts_paint', 03:52:07 INFO - 'tpaint', 03:52:07 INFO - 'sessionrestore', 03:52:07 INFO - 'sessionrestore_no_auto_restore', 03:52:07 INFO - 'tabpaint']}, 03:52:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:07 INFO - 'ts_paint', 03:52:07 INFO - 'tpaint', 03:52:07 INFO - 'sessionrestore', 03:52:07 INFO - 'sessionrestore_no_auto_restore', 03:52:07 INFO - 'tabpaint']}, 03:52:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:07 INFO - 'ts_paint', 03:52:07 INFO - 'tpaint', 03:52:07 INFO - 'sessionrestore', 03:52:07 INFO - 'sessionrestore_no_auto_restore', 03:52:07 INFO - 'tabpaint']}, 03:52:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['a11yr', 03:52:07 INFO - 'ts_paint', 03:52:07 INFO - 'tpaint', 03:52:07 INFO - 'sessionrestore', 03:52:07 INFO - 'sessionrestore_no_auto_restore', 03:52:07 INFO - 'tabpaint']}, 03:52:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['a11yr', 03:52:07 INFO - 'ts_paint', 03:52:07 INFO - 'tpaint', 03:52:07 INFO - 'sessionrestore', 03:52:07 INFO - 'sessionrestore_no_auto_restore', 03:52:07 INFO - 'tabpaint']}, 03:52:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['tsvgx', 03:52:07 INFO - 'tsvgr_opacity', 03:52:07 INFO - 'tart', 03:52:07 INFO - 'tscrollx', 03:52:07 INFO - 'cart']}, 03:52:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:07 INFO - 'tsvgr_opacity', 03:52:07 INFO - 'tart', 03:52:07 INFO - 'tscrollx', 03:52:07 INFO - 'cart']}, 03:52:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'talos_options': ['--disable-e10s'], 03:52:07 INFO - 'tests': ['tp5o']}, 03:52:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'tests': ['tp5o']}, 03:52:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'talos_options': ['--disable-e10s', 03:52:07 INFO - '--xperf_path', 03:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:07 INFO - 'tests': ['tp5n']}, 03:52:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:07 INFO - 'talos_options': ['--xperf_path', 03:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:07 INFO - 'tests': ['tp5n']}}, 03:52:07 INFO - 'talos.zip': {'path': '', 03:52:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:07 INFO - Running post-action listener: _resource_record_post_action 03:52:07 INFO - [mozharness: 2016-09-15 10:52:07.473310Z] Finished populate-webroot step (success) 03:52:07 INFO - [mozharness: 2016-09-15 10:52:07.473399Z] Running create-virtualenv step. 03:52:07 INFO - Running pre-action listener: _resource_record_pre_action 03:52:07 INFO - Running main action method: create_virtualenv 03:52:07 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:07 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 03:52:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:07 INFO - Using real prefix '/usr' 03:52:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:10 INFO - Installing pip.................done. 03:52:10 INFO - Return code: 0 03:52:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:10 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:10 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 03:52:10 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 03:52:10 INFO - Using env: {'DISPLAY': ':0', 03:52:10 INFO - 'HOME': '/home/cltbld', 03:52:10 INFO - 'LANG': 'en_US.UTF-8', 03:52:10 INFO - 'LANGUAGE': 'en_US:en', 03:52:10 INFO - 'LOGNAME': 'cltbld', 03:52:10 INFO - 'MAIL': '/var/mail/cltbld', 03:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:10 INFO - 'MOZ_NO_REMOTE': '1', 03:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:10 INFO - 'NO_EM_RESTART': '1', 03:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:10 INFO - 'PWD': '/builds/slave/test', 03:52:10 INFO - 'SHELL': '/bin/bash', 03:52:10 INFO - 'SHLVL': '1', 03:52:10 INFO - 'TERM': 'linux', 03:52:10 INFO - 'TMOUT': '86400', 03:52:10 INFO - 'USER': 'cltbld', 03:52:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:10 INFO - '_': '/tools/buildbot/bin/python'} 03:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:10 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 03:52:10 INFO - Cleaning up... 03:52:10 INFO - Return code: 0 03:52:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:10 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:10 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 03:52:10 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 03:52:10 INFO - Using env: {'DISPLAY': ':0', 03:52:10 INFO - 'HOME': '/home/cltbld', 03:52:10 INFO - 'LANG': 'en_US.UTF-8', 03:52:10 INFO - 'LANGUAGE': 'en_US:en', 03:52:10 INFO - 'LOGNAME': 'cltbld', 03:52:10 INFO - 'MAIL': '/var/mail/cltbld', 03:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:10 INFO - 'MOZ_NO_REMOTE': '1', 03:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:10 INFO - 'NO_EM_RESTART': '1', 03:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:10 INFO - 'PWD': '/builds/slave/test', 03:52:10 INFO - 'SHELL': '/bin/bash', 03:52:10 INFO - 'SHLVL': '1', 03:52:10 INFO - 'TERM': 'linux', 03:52:10 INFO - 'TMOUT': '86400', 03:52:10 INFO - 'USER': 'cltbld', 03:52:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:10 INFO - '_': '/tools/buildbot/bin/python'} 03:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:10 INFO - Downloading/unpacking psutil>=3.1.1 03:52:10 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 03:52:10 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 03:52:10 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 03:52:10 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 03:52:10 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 03:52:10 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 03:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:12 INFO - Installing collected packages: psutil 03:52:12 INFO - Running setup.py install for psutil 03:52:12 INFO - building 'psutil._psutil_linux' extension 03:52:12 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 03:52:12 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 03:52:12 INFO - building 'psutil._psutil_posix' extension 03:52:12 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 03:52:12 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 03:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:12 INFO - Successfully installed psutil 03:52:12 INFO - Cleaning up... 03:52:13 INFO - Return code: 0 03:52:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:13 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')]} 03:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:13 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')]} 03:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:13 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:13 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 03:52:13 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 03:52:13 INFO - Using env: {'DISPLAY': ':0', 03:52:13 INFO - 'HOME': '/home/cltbld', 03:52:13 INFO - 'LANG': 'en_US.UTF-8', 03:52:13 INFO - 'LANGUAGE': 'en_US:en', 03:52:13 INFO - 'LOGNAME': 'cltbld', 03:52:13 INFO - 'MAIL': '/var/mail/cltbld', 03:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:13 INFO - 'MOZ_NO_REMOTE': '1', 03:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:13 INFO - 'NO_EM_RESTART': '1', 03:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:13 INFO - 'PWD': '/builds/slave/test', 03:52:13 INFO - 'SHELL': '/bin/bash', 03:52:13 INFO - 'SHLVL': '1', 03:52:13 INFO - 'TERM': 'linux', 03:52:13 INFO - 'TMOUT': '86400', 03:52:13 INFO - 'USER': 'cltbld', 03:52:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:13 INFO - '_': '/tools/buildbot/bin/python'} 03:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:13 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 03:52:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:15 INFO - Installing collected packages: mozsystemmonitor 03:52:15 INFO - Running setup.py install for mozsystemmonitor 03:52:15 INFO - Successfully installed mozsystemmonitor 03:52:15 INFO - Cleaning up... 03:52:15 INFO - Return code: 0 03:52:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:15 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:15 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 03:52:15 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 03:52:15 INFO - Using env: {'DISPLAY': ':0', 03:52:15 INFO - 'HOME': '/home/cltbld', 03:52:15 INFO - 'LANG': 'en_US.UTF-8', 03:52:15 INFO - 'LANGUAGE': 'en_US:en', 03:52:15 INFO - 'LOGNAME': 'cltbld', 03:52:15 INFO - 'MAIL': '/var/mail/cltbld', 03:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:15 INFO - 'MOZ_NO_REMOTE': '1', 03:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:15 INFO - 'NO_EM_RESTART': '1', 03:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:15 INFO - 'PWD': '/builds/slave/test', 03:52:15 INFO - 'SHELL': '/bin/bash', 03:52:15 INFO - 'SHLVL': '1', 03:52:15 INFO - 'TERM': 'linux', 03:52:15 INFO - 'TMOUT': '86400', 03:52:15 INFO - 'USER': 'cltbld', 03:52:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:15 INFO - '_': '/tools/buildbot/bin/python'} 03:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:15 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:15 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 03:52:15 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 03:52:15 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 03:52:15 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 03:52:15 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 03:52:15 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 03:52:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:17 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 03:52:17 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 03:52:17 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 03:52:17 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 03:52:17 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 03:52:17 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 03:52:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:17 INFO - warning: no files found matching '*.txt' 03:52:17 INFO - no previously-included directories found matching 'build' 03:52:17 INFO - no previously-included directories found matching 'dist' 03:52:17 INFO - no previously-included directories found matching '.git*' 03:52:17 INFO - Installing collected packages: jsonschema, functools32 03:52:17 INFO - Running setup.py install for functools32 03:52:17 INFO - warning: no files found matching '*.txt' 03:52:17 INFO - no previously-included directories found matching 'build' 03:52:17 INFO - no previously-included directories found matching 'dist' 03:52:17 INFO - no previously-included directories found matching '.git*' 03:52:17 INFO - Successfully installed jsonschema functools32 03:52:17 INFO - Cleaning up... 03:52:17 INFO - Return code: 0 03:52:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:17 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')]} 03:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 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')]} 03:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:17 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:17 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 03:52:17 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 03:52:17 INFO - Using env: {'DISPLAY': ':0', 03:52:17 INFO - 'HOME': '/home/cltbld', 03:52:17 INFO - 'LANG': 'en_US.UTF-8', 03:52:17 INFO - 'LANGUAGE': 'en_US:en', 03:52:17 INFO - 'LOGNAME': 'cltbld', 03:52:17 INFO - 'MAIL': '/var/mail/cltbld', 03:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:17 INFO - 'MOZ_NO_REMOTE': '1', 03:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:17 INFO - 'NO_EM_RESTART': '1', 03:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:17 INFO - 'PWD': '/builds/slave/test', 03:52:17 INFO - 'SHELL': '/bin/bash', 03:52:17 INFO - 'SHLVL': '1', 03:52:17 INFO - 'TERM': 'linux', 03:52:17 INFO - 'TMOUT': '86400', 03:52:17 INFO - 'USER': 'cltbld', 03:52:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:17 INFO - '_': '/tools/buildbot/bin/python'} 03:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:18 INFO - Cleaning up... 03:52:18 INFO - Return code: 0 03:52:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:18 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')]} 03:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:18 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')]} 03:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:18 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:18 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 03:52:18 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 03:52:18 INFO - Using env: {'DISPLAY': ':0', 03:52:18 INFO - 'HOME': '/home/cltbld', 03:52:18 INFO - 'LANG': 'en_US.UTF-8', 03:52:18 INFO - 'LANGUAGE': 'en_US:en', 03:52:18 INFO - 'LOGNAME': 'cltbld', 03:52:18 INFO - 'MAIL': '/var/mail/cltbld', 03:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:18 INFO - 'MOZ_NO_REMOTE': '1', 03:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:18 INFO - 'NO_EM_RESTART': '1', 03:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:18 INFO - 'PWD': '/builds/slave/test', 03:52:18 INFO - 'SHELL': '/bin/bash', 03:52:18 INFO - 'SHLVL': '1', 03:52:18 INFO - 'TERM': 'linux', 03:52:18 INFO - 'TMOUT': '86400', 03:52:18 INFO - 'USER': 'cltbld', 03:52:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:18 INFO - '_': '/tools/buildbot/bin/python'} 03:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:18 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:18 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 03:52:18 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 03:52:18 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 03:52:18 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 03:52:18 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 03:52:18 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 03:52:20 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 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 03:52:20 INFO - Downloading docopt-0.6.1.tar.gz 03:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:20 INFO - Running setup.py install for blobuploader 03:52:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:21 INFO - Running setup.py install for requests 03:52:21 INFO - Running setup.py install for docopt 03:52:21 INFO - Successfully installed blobuploader requests docopt 03:52:21 INFO - Cleaning up... 03:52:21 INFO - Return code: 0 03:52:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:21 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:21 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 03:52:21 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 03:52:21 INFO - Using env: {'DISPLAY': ':0', 03:52:21 INFO - 'HOME': '/home/cltbld', 03:52:21 INFO - 'LANG': 'en_US.UTF-8', 03:52:21 INFO - 'LANGUAGE': 'en_US:en', 03:52:21 INFO - 'LOGNAME': 'cltbld', 03:52:21 INFO - 'MAIL': '/var/mail/cltbld', 03:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:21 INFO - 'MOZ_NO_REMOTE': '1', 03:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:21 INFO - 'NO_EM_RESTART': '1', 03:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:21 INFO - 'PWD': '/builds/slave/test', 03:52:21 INFO - 'SHELL': '/bin/bash', 03:52:21 INFO - 'SHLVL': '1', 03:52:21 INFO - 'TERM': 'linux', 03:52:21 INFO - 'TMOUT': '86400', 03:52:21 INFO - 'USER': 'cltbld', 03:52:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:21 INFO - '_': '/tools/buildbot/bin/python'} 03:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:21 INFO - Running setup.py (path:/tmp/pip-tJmvHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:21 INFO - Running setup.py (path:/tmp/pip-gvg325-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:21 INFO - Running setup.py (path:/tmp/pip-h_sxNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:22 INFO - Running setup.py (path:/tmp/pip-6IARCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:22 INFO - Running setup.py (path:/tmp/pip-bmMkSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:22 INFO - Running setup.py (path:/tmp/pip-oZJNdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:22 INFO - Running setup.py (path:/tmp/pip-GTPqnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:22 INFO - Running setup.py (path:/tmp/pip-xVOI_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:22 INFO - Running setup.py (path:/tmp/pip-Hq73vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:22 INFO - Running setup.py (path:/tmp/pip-GUvHPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:22 INFO - Running setup.py (path:/tmp/pip-DXMb4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:22 INFO - Running setup.py (path:/tmp/pip-VmQVmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:22 INFO - Running setup.py (path:/tmp/pip-n5ID7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:22 INFO - Running setup.py (path:/tmp/pip-mAVUxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:22 INFO - Running setup.py (path:/tmp/pip-t6KSvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:22 INFO - Running setup.py (path:/tmp/pip-RjBnCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:22 INFO - Running setup.py (path:/tmp/pip-MuTjw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:23 INFO - Running setup.py install for manifestparser 03:52:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Running setup.py install for mozcrash 03:52:23 INFO - Running setup.py install for mozdebug 03:52:23 INFO - Running setup.py install for mozdevice 03:52:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Running setup.py install for mozfile 03:52:23 INFO - Running setup.py install for mozhttpd 03:52:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Running setup.py install for mozinfo 03:52:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Running setup.py install for mozInstall 03:52:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Running setup.py install for mozleak 03:52:23 INFO - Running setup.py install for mozlog 03:52:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for moznetwork 03:52:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for mozprocess 03:52:24 INFO - Running setup.py install for mozprofile 03:52:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for mozrunner 03:52:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for mozscreenshot 03:52:24 INFO - Running setup.py install for moztest 03:52:24 INFO - Running setup.py install for mozversion 03:52:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:24 INFO - Cleaning up... 03:52:24 INFO - Return code: 0 03:52:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:24 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')]} 03:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:24 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')]} 03:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:24 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:24 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 03:52:24 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 03:52:24 INFO - Using env: {'DISPLAY': ':0', 03:52:24 INFO - 'HOME': '/home/cltbld', 03:52:24 INFO - 'LANG': 'en_US.UTF-8', 03:52:24 INFO - 'LANGUAGE': 'en_US:en', 03:52:24 INFO - 'LOGNAME': 'cltbld', 03:52:24 INFO - 'MAIL': '/var/mail/cltbld', 03:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:24 INFO - 'MOZ_NO_REMOTE': '1', 03:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:24 INFO - 'NO_EM_RESTART': '1', 03:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:24 INFO - 'PWD': '/builds/slave/test', 03:52:24 INFO - 'SHELL': '/bin/bash', 03:52:24 INFO - 'SHLVL': '1', 03:52:24 INFO - 'TERM': 'linux', 03:52:24 INFO - 'TMOUT': '86400', 03:52:24 INFO - 'USER': 'cltbld', 03:52:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:24 INFO - '_': '/tools/buildbot/bin/python'} 03:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:25 INFO - Running setup.py (path:/tmp/pip-yv9zNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:25 INFO - Running setup.py (path:/tmp/pip-Jopx0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:25 INFO - Running setup.py (path:/tmp/pip-d2lgM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:25 INFO - Running setup.py (path:/tmp/pip-sA5IfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:25 INFO - Running setup.py (path:/tmp/pip-M6OY3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:25 INFO - Running setup.py (path:/tmp/pip-zrALQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:25 INFO - Running setup.py (path:/tmp/pip-5xlRRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:25 INFO - Running setup.py (path:/tmp/pip-rt2nkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:25 INFO - Running setup.py (path:/tmp/pip-kALgiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:25 INFO - Running setup.py (path:/tmp/pip-NNOD2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:25 INFO - Running setup.py (path:/tmp/pip-xntNI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:25 INFO - Running setup.py (path:/tmp/pip-PvVN0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:25 INFO - Running setup.py (path:/tmp/pip-1RgPHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:25 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)) 03:52:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:25 INFO - Running setup.py (path:/tmp/pip-yOZclq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:26 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)) 03:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:26 INFO - Running setup.py (path:/tmp/pip-DPSXZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:26 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)) 03:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:26 INFO - Running setup.py (path:/tmp/pip-Aa2p6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:26 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)) 03:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:26 INFO - Running setup.py (path:/tmp/pip-TGMEEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:26 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)) 03:52:26 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)) 03:52:26 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)) 03:52:26 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)) 03:52:26 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)) 03:52:26 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)) 03:52:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:28 INFO - Downloading blessings-1.6.tar.gz 03:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:28 INFO - Installing collected packages: blessings 03:52:28 INFO - Running setup.py install for blessings 03:52:28 INFO - Successfully installed blessings 03:52:28 INFO - Cleaning up... 03:52:28 INFO - Return code: 0 03:52:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:28 INFO - Reading from file tmpfile_stdout 03:52:28 INFO - Current package versions: 03:52:28 INFO - argparse == 1.2.1 03:52:28 INFO - blessings == 1.6 03:52:28 INFO - blobuploader == 1.2.4 03:52:28 INFO - docopt == 0.6.1 03:52:28 INFO - functools32 == 3.2.3-2 03:52:28 INFO - jsonschema == 2.5.1 03:52:28 INFO - manifestparser == 1.1 03:52:28 INFO - mozInstall == 1.12 03:52:28 INFO - mozcrash == 0.17 03:52:28 INFO - mozdebug == 0.1 03:52:28 INFO - mozdevice == 0.48 03:52:28 INFO - mozfile == 1.2 03:52:28 INFO - mozhttpd == 0.7 03:52:28 INFO - mozinfo == 0.9 03:52:28 INFO - mozleak == 0.1 03:52:28 INFO - mozlog == 3.3 03:52:28 INFO - moznetwork == 0.27 03:52:28 INFO - mozprocess == 0.23 03:52:28 INFO - mozprofile == 0.28 03:52:28 INFO - mozrunner == 6.12 03:52:28 INFO - mozscreenshot == 0.1 03:52:28 INFO - mozsystemmonitor == 0.3 03:52:28 INFO - moztest == 0.7 03:52:28 INFO - mozversion == 1.4 03:52:28 INFO - psutil == 3.1.1 03:52:28 INFO - requests == 1.2.3 03:52:28 INFO - wsgiref == 0.1.2 03:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:28 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 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:28 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 03:52:28 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 03:52:28 INFO - Using env: {'DISPLAY': ':0', 03:52:28 INFO - 'HOME': '/home/cltbld', 03:52:28 INFO - 'LANG': 'en_US.UTF-8', 03:52:28 INFO - 'LANGUAGE': 'en_US:en', 03:52:28 INFO - 'LOGNAME': 'cltbld', 03:52:28 INFO - 'MAIL': '/var/mail/cltbld', 03:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:28 INFO - 'MOZ_NO_REMOTE': '1', 03:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:28 INFO - 'NO_EM_RESTART': '1', 03:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:28 INFO - 'PWD': '/builds/slave/test', 03:52:28 INFO - 'SHELL': '/bin/bash', 03:52:28 INFO - 'SHLVL': '1', 03:52:28 INFO - 'TERM': 'linux', 03:52:28 INFO - 'TMOUT': '86400', 03:52:28 INFO - 'USER': 'cltbld', 03:52:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:28 INFO - '_': '/tools/buildbot/bin/python'} 03:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 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)) 03:52:28 INFO - Cleaning up... 03:52:28 INFO - Return code: 0 03:52:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2953030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b82400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, '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': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', '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 03:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:28 INFO - Using env: {'DISPLAY': ':0', 03:52:28 INFO - 'HOME': '/home/cltbld', 03:52:28 INFO - 'LANG': 'en_US.UTF-8', 03:52:28 INFO - 'LANGUAGE': 'en_US:en', 03:52:28 INFO - 'LOGNAME': 'cltbld', 03:52:28 INFO - 'MAIL': '/var/mail/cltbld', 03:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:28 INFO - 'MOZ_NO_REMOTE': '1', 03:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:28 INFO - 'NO_EM_RESTART': '1', 03:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:28 INFO - 'PWD': '/builds/slave/test', 03:52:28 INFO - 'SHELL': '/bin/bash', 03:52:28 INFO - 'SHLVL': '1', 03:52:28 INFO - 'TERM': 'linux', 03:52:28 INFO - 'TMOUT': '86400', 03:52:28 INFO - 'USER': 'cltbld', 03:52:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:28 INFO - '_': '/tools/buildbot/bin/python'} 03:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:29 INFO - Cleaning up... 03:52:29 INFO - Return code: 0 03:52:29 INFO - Running post-action listener: _resource_record_post_action 03:52:29 INFO - Running post-action listener: _start_resource_monitoring 03:52:29 INFO - Starting resource monitoring. 03:52:29 INFO - [mozharness: 2016-09-15 10:52:29.090349Z] Finished create-virtualenv step (success) 03:52:29 INFO - [mozharness: 2016-09-15 10:52:29.090780Z] Running install step. 03:52:29 INFO - Running pre-action listener: _resource_record_pre_action 03:52:29 INFO - Running main action method: install 03:52:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:29 INFO - Reading from file tmpfile_stdout 03:52:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:29 INFO - Reading from file tmpfile_stdout 03:52:29 INFO - Output received: 03:52:29 INFO - Usage: mozinstall [options] installer 03:52:29 INFO - Options: 03:52:29 INFO - -h, --help show this help message and exit 03:52:29 INFO - -d DEST, --destination=DEST 03:52:29 INFO - Directory to install application into. [default: 03:52:29 INFO - "/builds/slave/test"] 03:52:29 INFO - --app=APP Application being installed. [default: firefox] 03:52:29 INFO - mkdir: /builds/slave/test/build/application 03:52:29 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'] 03:52:29 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 03:52:46 INFO - Reading from file tmpfile_stdout 03:52:46 INFO - Output received: 03:52:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:52:46 INFO - Running post-action listener: _resource_record_post_action 03:52:46 INFO - [mozharness: 2016-09-15 10:52:46.070696Z] Finished install step (success) 03:52:46 INFO - [mozharness: 2016-09-15 10:52:46.070970Z] Running run-tests step. 03:52:46 INFO - Running pre-action listener: _resource_record_pre_action 03:52:46 INFO - Running main action method: run_tests 03:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:46 INFO - Python 2.7.3 03:52:46 INFO - Return code: 0 03:52:46 INFO - grabbing minidump binary from tooltool 03:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:46 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 0x2c11570>, '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 0x2c12470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c12900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:46 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 03:52:46 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 03:52:46 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 03:52:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:46 INFO - Return code: 0 03:52:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:52:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:52:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:46 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/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:52:46 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/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 03:52:46 INFO - Using env: {'DISPLAY': ':0', 03:52:46 INFO - 'HOME': '/home/cltbld', 03:52:46 INFO - 'LANG': 'en_US.UTF-8', 03:52:46 INFO - 'LANGUAGE': 'en_US:en', 03:52:46 INFO - 'LOGNAME': 'cltbld', 03:52:46 INFO - 'MAIL': '/var/mail/cltbld', 03:52:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:46 INFO - 'MOZ_NO_REMOTE': '1', 03:52:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:46 INFO - 'NO_EM_RESTART': '1', 03:52:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:46 INFO - 'PWD': '/builds/slave/test', 03:52:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:46 INFO - 'SHELL': '/bin/bash', 03:52:46 INFO - 'SHLVL': '1', 03:52:46 INFO - 'TERM': 'linux', 03:52:46 INFO - 'TMOUT': '86400', 03:52:46 INFO - 'USER': 'cltbld', 03:52:46 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701', 03:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:46 INFO - '_': '/tools/buildbot/bin/python'} 03:52:46 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/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 03:52:46 INFO - mozversion application_buildid: 20160915004005 03:52:46 INFO - mozversion application_changeset: 9f8472060b5eaad0bc976f07b932981366a938dd 03:52:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:52:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:46 INFO - mozversion application_name: Firefox 03:52:46 INFO - mozversion application_remotingname: firefox-dev 03:52:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:52:46 INFO - mozversion application_vendor: Mozilla 03:52:46 INFO - mozversion application_version: 50.0a2 03:52:46 INFO - mozversion platform_buildid: 20160915004005 03:52:46 INFO - mozversion platform_changeset: 9f8472060b5eaad0bc976f07b932981366a938dd 03:52:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:52:46 INFO - mozversion platform_version: 50.0a2 03:52:46 INFO - using testdate: 1473936766 03:52:46 INFO - actual date: 1473936766 03:52:46 INFO - starting webserver on 'localhost:57924' 03:52:46 INFO - SUITE-START | Running 2 tests 03:52:46 INFO - TEST-START | dromaeo_css 03:52:46 INFO - operating with platform_type : linux_ 03:52:46 INFO - Initialising browser for dromaeo_css test... 03:52:46 INFO - TEST-INFO | started process 10159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4fBgr/profile http://localhost:57924/getInfo.html) 03:52:50 INFO - PROCESS | 10159 | __metrics Screen width/height:1600/1200 03:52:50 INFO - PROCESS | 10159 | colorDepth:24 03:52:50 INFO - PROCESS | 10159 | Browser inner width/height: 1024/697 03:52:50 INFO - PROCESS | 10159 | __metrics 03:52:51 ERROR - PROCESS | 10159 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:52:52 INFO - TEST-INFO | 10159: exit 0 03:52:52 INFO - Browser initialized. 03:52:52 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:52 INFO - TEST-INFO | started process 10284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4fBgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:04 INFO - PROCESS | 10284 | RSS: Main: 153018368 03:53:04 INFO - PROCESS | 10284 | 03:53:53 INFO - PROCESS | 10284 | 1473936833848 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] 03:56:02 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:57924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57924/tests/dromaeo/cssquery-ext.html) 03:56:03 INFO - PROCESS | 10284 | RSS: Main: 159686656 03:56:03 INFO - PROCESS | 10284 | 03:59:05 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:57924/tests/dromaeo/cssquery-ext.html (next: http://localhost:57924/tests/dromaeo/cssquery-jquery.html) 03:59:06 INFO - PROCESS | 10284 | RSS: Main: 155471872 03:59:06 INFO - PROCESS | 10284 | 04:02:07 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:57924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57924/tests/dromaeo/cssquery-mootools.html) 04:02:08 INFO - PROCESS | 10284 | RSS: Main: 155066368 04:02:08 INFO - PROCESS | 10284 | 04:05:10 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:57924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57924/tests/dromaeo/cssquery-prototype.html) 04:05:10 INFO - PROCESS | 10284 | RSS: Main: 153591808 04:05:10 INFO - PROCESS | 10284 | 04:08:13 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:57924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57924/tests/dromaeo/cssquery-yui.html) 04:08:14 INFO - PROCESS | 10284 | RSS: Main: 156286976 04:08:14 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | Cycle 1(1): loaded http://localhost:57924/tests/dromaeo/cssquery-yui.html (next: http://localhost:57924/tests/dromaeo/cssquery-dojo.html) 04:11:16 INFO - PROCESS | 10284 | RSS: Main: 156786688 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | __start_tp_report 04:11:16 INFO - PROCESS | 10284 | _x_x_mozilla_page_load 04:11:16 INFO - PROCESS | 10284 | _x_x_mozilla_page_load_details 04:11:16 INFO - PROCESS | 10284 | |i|pagename|runs| 04:11:16 INFO - PROCESS | 10284 | |0;dojo.html;3322.9833850830746;3337.2324365395943;3348.1294863335534;3362.882299119531;3375.5949286085674;5684.204211410401;5778.971105144468;5800.738966746496;5803.854903627412;5817.272840894888;5771.971140144294;5800.216970708953;5824;5834.27071616048;5842.707864606774;5200.037992971303;5223.764930578114;5295.338082739658;5337.439568845273;5339.919901201485;5143.228515722634;5197.974010129944;5269.235960785683;5294.761735721882;5373.7581808818695;5321;5333.146696528556;5342.1452567589195;5358.490943360374;5367.946320536803;5344.4922732340365;5373.140297552392;5383.380911195223;5387.919181212285;5412.9458705412835;5098.770555325019;5146.330976973007;5162.586993040548;5292.391374991887;5292.470752924715;5681.289838770153;5721.313442386941;5725.08398656213;5740.827775166752;5766.04860198071;6166.660833654148;6204.751809927598;6225.937740622627;6236.407541283571;6236.688165591702;5970.701464926779;6039.3960603939695;6082.695865206722;6256.96871515644;6266.248050234001;5697.6296540724725;5718.513926316268;5724.1413787931315;5728.598998070137;5736.6558006519745;6258.968705156445;6268.529860260499;6275.403836635513;6279.560430769893;6282.780102696383;5951.5238780897425;6013.0980352946535;6015.2781666200335;6016.608920420159;6025.9397406026255;6184.474319682788;6208.534359923024;6228.252609686867;6231.875362492816;6242.219722534684;6205.441510264098;6211.534134939898;6215.06773983897;6216.875662486725;6224.595401298901;6068.605540639845;6097.634141951497;6101.481374083164;6192.380761923771;6215.440610345091;4750.572448479585;4752.619790416758;4759.785809638574;4770.7853146607795;4780.4741478437345;4237.597428244312;4239.618434340862;4244;4247.51153617338;4270.274053410928;5866.384029676908;5887.499562537232;5894.557908156906;5970.940290597126;6013.1581578579035;6203.2245969253845;6207.441330280297;6228.657423841732;6229.5327850410495;6263.185785847811;5947.1376650385455;5960.880782384328;5975.551833612496;5982.46157845796;6041.486473649701;5222.947770522323;5323.387810401776;5330.92003619946;5341.0653135701095;5346.304980352529;6488.740450381932;6513.283538810727;6556.409923106943;6565.474762019027;6572.934270657328;6310.368963103745;6315.905261421174;6316.873662526816;6319.6208227506495;6320.5891617044745;6285.120083188449;6286.497080233662;6318.494520438446;6461.450776684034;6546.541742078009;6104.603200791934;6107.786227482017;6109.20580324555;6112.755489780537;6143.293521245114;6188.535859810622;6219.346968568235;6219.564630476004;6221.782237621662;6221.813345599639;5861.912071318849;6022.367651396716;6070.605410648471;6079.270487541523;6098.512119030378;6064.636121832704;6072.180255665428;6095.847603809941;6113.174721412553;6128.540359473147;5983.9401605983385;5989.1914591529585;6034.758609655564;6037.788677396446;6038.849028774316;5926.1999630049395;5970.0746384310505;5986.88026239464;6104.053871649901;6110.816675499742;5932.644041357532;5934.347221805511;5955.67243801595;5957.225560677084;5988.8802223956145 04:11:16 INFO - PROCESS | 10284 | |1;ext.html;582.2430839908121;629.9559030867839;659.9868002639947;666.813292278162;699.1505321034941;40669.99999999996;45546.54453455465;45674.771626141905;45833.770831145885;45961.54038459614;46284;46628;46925.29612055822;46957.530424695746;47012.29481557779;9098.636054557826;9134.17792398684;9163.404378715362;9206.309526785484;9231.399959002643;9075.228605568534;9078.500682462462;9184.21934135596;9194;9212;9206.447613143233;9215;9218.35471516994;9235.353525253235;9275.536223188847;9158.175764181222;9184.127507886773;9197.402168859036;9198.126178013077;9211.355205135644;9190.632374705005;9218.907810921872;9235.215006724437;9257.028012058705;9279.072092790735;43370.78314608438;43800.780996094814;44021.55978440207;44039.55960440387;44144.55855441437;3865;4067.7355971861734;4122.299209134454;4136.172765446892;4366.759828209447;34404.65595344039;34658.13354666128;34683;34807.4778878317;34968.475472867925;4632.72203667781;4680.9297860532115;4699.103395176727;4701.247800351962;4790.592799612037;340027;341816;342929;343044;343307;61489;61652;61733.69133154395;62096;62234.37765622376;38788.80605596954;64169.679151603945;64173.67913160404;64314.35685643084;64461.35538644553;16722.74915876263;17357.56606084858;17371.56571085733;17383.217755201047;17411.73882391765;15276.388944442098;15307.693846123015;15363.61590960235;15411.075335479907;15413.460528881435;20214;20513.89743051305;20573.89713051425;20578.27976020832;20823;7698.498792735475;7752.728654497066;7783.338416234684;7789.715656388963;7842.921570784333;1043.598214687351;1078.1428764132534;1108.351614305624;1109.7003808971533;1115.0967716149944;33662.49506257408;33816;34005.829970850486;34092.48861267083;34154.829225854206;1164.55746816211;1166.1428849795393;1204.2714157934324;1205.391277404905;1212.8969037631723;17755.378561750276;17894.731579026324;18012.36956706535;18123;18131.093445327682;650431;654038;659775;664648;668398;62475;62847.37152628507;63135;63427;63678.681606592596;1404.1013751199241;1409.4644035266738;1450.166154461189;1452.7021960498284;1453.302414840861;32483.35033299368;32900.67099329072;33310.66689333173;33580.160495987795;33678.49482257719;53139.734301328244;54026.72986635042;54084.72957635186;54093.45906540884;54101.72949135229;471552;472033;474551;475880;476980;27504.17487475379;27894.721052789213;28192.43615127727;28251.15246542607;30448.84775576108;52026.73986630043;52149.47850521598;52259.21611175912;52404.47595523996;53575.46424535705;42120.78939605282;43961.34057989069;44183.55816441923;44263.778681106385;45325.54674453345;43304.133917322106;44444.55555444404;44529.10941781211;45690;46267;43996;46882.296765547864;47075.52924470711;47747.28379074386;48140.518594813606;36851.447228292134;39602.405963911144;39879.40180897347;40566.39150412687;40588.79705601453;29805.403891922473;30018.24954376158;30254.243643909078;30713;30735.538966915963 04:11:16 INFO - PROCESS | 10284 | |2;jquery.html;407.27098493696286;412.1386302627508;431.62879923265984;433.25480174100545;440.21861196376426;19015.954122523257;19552.706709399354;20437.795622043795;20777.688334674993;20807.791922080774;19579.608407831834;19993.500162495944;20035;20551.075201615924;20749.792502074975;5319.175527793198;5664.178694089354;5669.121286200645;5697.373288938214;5711.543076553887;5594.748236329375;5792.565557583177;5865.120231965218;5920.792772252972;5925.585209035369;5859.472647461727;5867.88264234715;5871.794487192949;5889.293284805829;5892.057270836667;5859.970700146515;5875.177475153482;5904.498117659982;5913.172155898178;5915.40845915405;5702.942970570282;5725.083986562172;5728.083506638959;5742.425757424266;5752.884942301131;23705.644415333783;24022.639660404933;24192.87903560471;24711.135110271054;24929.501409971697;2405.074046492113;2495.8502489850484;2496.8252222344445;2557.130575604285;2599.8700064996674;9623.470709110996;9913.504324783731;10274.691759247235;13490.325483725774;14065.156090634595;1963.0675429171172;2009.1661960286463;2014.0533949043927;2037.7758446570865;2103.758067822205;78628;79100.20899790985;80506.59746701288;83809;84670;11704;11745.354005529607;11882.88117118835;11886.940565297118;11963.76072478563;16674.66650667004;16706.83293167077;16740.414085507193;16772.664546709242;16801.15994200285;8558.315334773204;8710.782230444289;8854.24738897188;8875.955620221857;8985.775355616162;8158.224968627971;8286.875696864552;8297.962754655668;8331.33349332052;8454.830903381899;4261.595148460891;4505.459344878635;4921.557059864629;5014.674046186986;5060.5698515625845;1990.0398107863743;2132;2136.44452442363;2173.7282839645045;2184.9890750546465;988.6885631026204;994.7314225159166;1017.862588550551;1021.6424251511911;1045.6761292057247;20418.285360012327;20748.962551872344;20750.896245518677;21089.78910210909;21140.47148821292;1023.6417253961054;1058.9258751887294;1074.7742973975396;1128.5937062657438;1130.559081958037;11038.392888391216;11538.480768365444;11666.591669291534;11710;11886;374606;376035;380616;536008;557275;62966.37033629605;64660.67669661622;97305;103410;103726.48136759418;1061.1722856172198;1072.56025029739;1095.370162156763;1100.5982816272003;1105.9225854190129;16112.033278003357;18335.633287333912;18408.171632276848;18753.249870005046;19371.3220037298;32594.185145371557;40048;44764;45350.09299814051;45367.546324536335;64297;64988;65066.674666626364;65404.34595654173;65482.345176549534;8229.25936665703;8432.747017589481;8445.239928406472;8596.312295016509;8846.557672116498;11619.0704743622;13651.11267767592;13831.377588008363;13902.86097139056;14013.859861401255;10932.726681832699;11563.942180289045;11649.708757281136;11857.762844742885;12092.45583948742;10848.132149428184;11643.068554515788;11998.520059197883;12004.519819207135;12433.626991189916;10981.725456863642;11043.503042362952;11355.886441135483;11448.141389395994;11750;8347.290480309242;8402;8434.114417986024;8689.8696519551;8791.912080879109;9423.952880235554;10499.370037797757;10619.1504679627;11282.774344513227;11432.657020289405 04:11:16 INFO - PROCESS | 10284 | |3;mootools.html;1566.577024203465;1573.8032745906762;1782.5828466369244;1821.9726704099448;1883.387898932847;8357.958210208955;9110.726678199657;9188.678396256133;9905.108540231378;9908.15780658644;9272.953635231814;9615.326927115104;9656.468894210815;9669.70990870275;9675.08086731761;2381.4522659788217;2416.492536567323;2416.5891798394314;2435.1598698449006;2435.3789783605157;2432.9878350608224;2460.9753902461016;2524.7222805491383;2525.6337831014494;2529.8229123961332;2472.777450029497;2487.465194983078;2491.451880586277;2519.685039370079;2538.2385284414695;2391.5695174868515;2407.987960060197;2419.588669926108;2439.0487709793197;2448.0697335012583;2372.264597974616;2390.768754091644;2400.279916025203;2403.230966090852;2418.0690434182966;9712.562934667956;9803;9803.754906127333;9807.705768826947;9837.55730992107;5782.392848750905;5784.595078344518;5811.970940145272;5846.50304724099;5847.093700476433;3561.269939662363;3638.272345530904;3640.6541378568995;3706.2772759311947;3733.4026555750947;1105.4528008635696;1141.3876662875196;1158.6292386436344;1160.9071274298035;1164.3072371938683;13690.52083177094;13795.2412617306;13908.51320203788;13917.095388799695;13961.092528985584;5014.122528557488;5138.152204886152;5144.6913185209005;5152.252923326097;5388.703621300866;11485.540578376771;11543.88456115445;11558.768824623461;11629.302241865515;11636.12729045325;5784;5807.854803629859;5812.418758124154;5846.970765146232;5849.5027922626205;4840.15297322967;5260.421353651095;5277;5331.786728530893;5388;4466.955330446719;4483.820647174141;4548.181327361107;4556.70381425213;4601.033782905561;1335.6660834791303;1380.3098450774612;1388.597306781022;1411.865872742088;1412.3220853989937;1040.7814358984547;1048.6539441984128;1049.1082579807255;1056.9524371403306;1073.538378497238;6333.904991425133;6483;6488.448481878999;6603;6604;473.5430309751107;478.27063727814664;478.394830539368;487.7000644603543;495.72982724415283;4334.349847522833;4390.517043125254;4414.9558504414545;4431.955680443219;4439.311906654474;11708.238964467282;12198.695032624255;12223.69440763988;12260.386980650932;12274.631761047183;10880.183986201067;11291.435428228555;12175.573854915036;12180.512779488721;12212.389380530938;8945.552722363856;9140.542972851465;9142.268618510503;9151.771205719777;9157.130072643089;6060.2424696912885;6167.414095660905;6213.565050446426;6260.342664020394;6285.779997700241;10230.948845255725;10400.635977741045;10518.947405262925;10627.628033018807;10714.946425267824;10612.416317102634;10899.29154604948;11175.441227938732;11200.775984480428;11246.775064498828;8399.41204115706;8850.247728942855;8968.461892286483;9024.909750902407;9270.490123043297;9358.766030849283;9589.280803939871;9615.51922403863;9685.273604479833;9733.561989710339;8427.662893484192;8439.451435656663;8440.155984401756;8493.235608795238;8565.48607083577;8140.87788683182;8297.875531867148;8329.541875196923;8337.333013358795;8515;7385.335319821027;7502.212267711811;7578.734744283924;7583.658735357032;7598.430117741081;5344.732763361894;5420.53925416344;5564.610477266714;5611.158326250932;5651.237082993907;5761.683107429131;5859.44335288147;5899.174115623902;5910.320313164041;5926.436988486087 04:11:16 INFO - PROCESS | 10284 | |4;prototype.html;333.7380156577087;343.4041937238891;343.958605675317;356.8536899871053;359.1900264902644;5646.2659854219;5719.170720245573;5846.444587764161;5868.031774757165;5901.350851406347;5664;5721.656700597967;5735.824156048011;5741.799037033705;5770.19217309577;4484.708493947883;4524.886877828048;4525.932111018321;4532.796024178903;4539.3417954396755;4426.468823741139;4459.910801783963;4464.508904020555;4480.7087539310005;4529;4398.296272596385;4420.756858372788;4431.534688857656;4431.7340959542535;4433.290673492242;4452.1986042512335;4459.576340247671;4472.575105364985;4485.798139083749;4515.119551687422;3750.5499340079364;3849.4418309344987;3875.7093218008763;3880.5925377835483;3908.355121404965;5601;5604.915926261109;5690.231818704505;5697.230873832021;5698.658080515141;5048.217526283432;5098.541131298164;5139.922901156486;5145.099607568661;5152.484751524855;6035.969820150915;6045.486133678643;6053.576249662526;6089.6041757286075;6091.543134264948;4273.572642735701;4297.35539669049;4307.935380969288;4315.180115777992;4317.827286908519;6271.341509141565;6314.494840412756;6373.713182906734;6425.22897252328;6438.323975982501;4354.346847972766;4374.343848422698;4386.815559798836;4399.406080179199;4400;4392.604665580113;4426.778661066934;4436.800343984529;4442.444694413199;4447.799849006802;4828.637852161102;5079.568236699848;5119.488051194925;5127.948720512822;5128.282040514331;5908.20239267702;6072.271327440735;6084.69576521181;6093.908591371133;6110.847228819315;1507.4723846653803;1527.427214794452;1534.0795522686299;1539.815222173324;1551.224387806097;944.2729098594044;979.9167070799062;992.4938281476499;992.9056739609725;998.2064258914036;5221.921671174935;5267.207610520496;5280.6303558750515;5287.867803304871;5323.148296272578;5417.566594672417;5431.321084864392;5460.771326451517;5489.258950041693;5528.75120619573;5087.694738315713;5154.226865970059;5263.394709608444;5320.255164277004;5363.517283444508;2933.4426458972725;2947.233719232972;2949.5694588124743;2953.985230073879;3000.5199168132995;5679.2333035040565;5692.57305702074;5725.51333136688;5755.884882302415;5771.835561664376;5223;5554.611177217556;5567.526760225345;5571.387147413781;5575.4424557544735;5621.522170615462;5692.715364231772;5697.943020569741;5734.541236701054;5760.567957403212;5168.741562921914;5462.289902312674;5476.274973383372;5503.614746967673;5532.391436942014;5416.025115479251;5424.860779236246;5427.402985671652;5428.755705993319;5447.618666693294;5689.829305120853;5723;5726.685032323262;5765.321158658634;5807.245058142415;4041.1715598302867;4048.5344185417875;4061.5532291447325;4342.717723347972;4345.261305578122;6015.608985415934;6091.5126789857595;6204.5036397089025;6209;6284.937150628435;6107.816765497042;6109.7861574844665;6115.816525504242;6126.326104128631;6136.171616831849;6094.7257373417415;6115.694215289307;6165.938340616716;6181.660008699565;6194.420422792159;5760.683162426107;6088.695565221809;6103.7253323601435;6110.541709371903;6151.81610528256;6223.222097237845;6236.220472440945;6261.622443062519;6266.373362663697;6276.403741644536;5896.321922978912;6001.279846418458;6024.3975602439405;6049.78825741097;6065.4541091300225 04:11:16 INFO - PROCESS | 10284 | |5;yui.html;825.2902503846694;830.6594296338499;855.0807881527357;885.9512726800025;924.9861252081216;14711;16045.438409655664;16224.918875405607;16312.673746525063;16340;15770.84229157708;15975.600609984756;16074;16171;16176.83823161768;880.3617377401381;894.9418287811271;901.6573701993234;902.1204325782376;903.3134817538652;880.0847118996236;888.1340692824476;891.692366133686;895.1317222294364;895.1898531828706;933.3466573398614;933.7198840347869;937.8124375124968;938.7653086728318;941.232895190421;931.6273490603779;932.2588542109006;932.5383934952242;933.0063482391299;936.6206686292063;687.0552989639247;687.7592842505134;693.8681650486442;694.0664805836142;695.0130814243786;14358.92820535901;14430.567082987527;14456.204908730017;14475.131492110508;14478.203698796562;14137.646558836008;14144.787828182585;14150.363233654407;14180.57458276243;14191.645208869757;12466.81299780504;12490.43793029316;12654.240745555297;12829.166104203197;12830.935845320713;3943.3493473576827;4040.4141399497203;4045.7167998240134;4057.9594204057876;4170.874873753793;59296.40703592952;79486.15415375422;83557.16442835494;83966;85588.57205713994;12397.318147501794;12422.130450868533;12494.312812795202;12763.596004439505;12808.615741527768;21651.13395464195;21760.45598860041;21792.237271695416;21803.781962180492;21827.345179644635;8992;9494.192993595483;9555.761105972268;9559.091886270793;9611.855822162674;4964.379452568429;5018.573421259161;5124.897502049938;5410.296661434067;5662.292213473316;3523.489094081344;3642.1440961374055;3664.1022949377575;3666.431703086026;3671.504346913186;641.5701480008405;663.4592806862391;663.6747993483255;664.833791552112;666.044226534924;563.107474652672;604.7067172421372;676.6041865508635;757.360030773995;766.0389403128011;9263.722088337361;9377.812443751087;9575.521223938775;9799.265055120895;10120.645777397756;645.7094307561522;648.6562122075308;660.4716227018366;670.0819876768858;683;4637.5130611286;4897.576636804576;4965.453800081988;4975.402951645826;4975.802400362097;78306;83720;90373;135379;141201;120239;120250;120854;123821;126608;85485;103416;103568.48215759023;104457.47771261095;104716;9263.76840578991;9494.90505094968;9545.427274363283;9680.75798105053;9748.184381941095;56986.43013569977;58345.708271458374;60262.39737602568;60414.69792651009;60444.69777651084;84899;90647;91652.54173729089;92114.53942730243;95136;12110;12230.388480576114;12568.434420451285;12685.175463594836;12813;13244.404001820134;13363.39864706071;13386.665333366744;13424.798628020782;13448.520662726896;12142.089343299465;12280.26318420862;12451.937740311241;13018.414171362501;13153.408096635865;11874.168808183344;12075.75848483043;12490.250584964931;12598.244105353708;12821.871781282067;11846.585369512026;12226.633201003984;12345.876541234473;12576.622701318975;12745.808812867628;9793.167580755715;9954.751131221778;10179.389236645826;10198;10222.6422075227;10426.218033647356;10473.371597704163;10609.840852387066;10619.1504679627;10642.095421888916 04:11:16 INFO - PROCESS | 10284 | __end_tp_report 04:11:16 INFO - PROCESS | 10284 | __start_cc_report 04:11:16 INFO - PROCESS | 10284 | _x_x_mozilla_cycle_collect,336 04:11:16 INFO - PROCESS | 10284 | __end_cc_report 04:11:16 INFO - PROCESS | 10284 | __startTimestamp1473937876731__endTimestamp 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | ------- Summary: start ------- 04:11:16 INFO - PROCESS | 10284 | Number of tests: 6 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | [#0] dojo.html Cycles:165 Average:5762.62 Median:5983.94 stddev:653.12 (10.9%) stddev-sans-first:626.45 04:11:16 INFO - PROCESS | 10284 | Values: 3323.0 3337.2 3348.1 3362.9 3375.6 5684.2 5779.0 5800.7 5803.9 5817.3 5772.0 5800.2 5824.0 5834.3 5842.7 5200.0 5223.8 5295.3 5337.4 5339.9 5143.2 5198.0 5269.2 5294.8 5373.8 5321.0 5333.1 5342.1 5358.5 5367.9 5344.5 5373.1 5383.4 5387.9 5412.9 5098.8 5146.3 5162.6 5292.4 5292.5 5681.3 5721.3 5725.1 5740.8 5766.0 6166.7 6204.8 6225.9 6236.4 6236.7 5970.7 6039.4 6082.7 6257.0 6266.2 5697.6 5718.5 5724.1 5728.6 5736.7 6259.0 6268.5 6275.4 6279.6 6282.8 5951.5 6013.1 6015.3 6016.6 6025.9 6184.5 6208.5 6228.3 6231.9 6242.2 6205.4 6211.5 6215.1 6216.9 6224.6 6068.6 6097.6 6101.5 6192.4 6215.4 4750.6 4752.6 4759.8 4770.8 4780.5 4237.6 4239.6 4244.0 4247.5 4270.3 5866.4 5887.5 5894.6 5970.9 6013.2 6203.2 6207.4 6228.7 6229.5 6263.2 5947.1 5960.9 5975.6 5982.5 6041.5 5222.9 5323.4 5330.9 5341.1 5346.3 6488.7 6513.3 6556.4 6565.5 6572.9 6310.4 6315.9 6316.9 6319.6 6320.6 6285.1 6286.5 6318.5 6461.5 6546.5 6104.6 6107.8 6109.2 6112.8 6143.3 6188.5 6219.3 6219.6 6221.8 6221.8 5861.9 6022.4 6070.6 6079.3 6098.5 6064.6 6072.2 6095.8 6113.2 6128.5 5983.9 5989.2 6034.8 6037.8 6038.8 5926.2 5970.1 5986.9 6104.1 6110.8 5932.6 5934.3 5955.7 5957.2 5988.9 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | [#1] ext.html Cycles:180 Average:65986.14 Median:45436.05 stddev:135577.57 (298.4%) stddev-sans-first:135868.97 04:11:16 INFO - PROCESS | 10284 | Values: 582.2 630.0 660.0 666.8 699.2 40670.0 45546.5 45674.8 45833.8 45961.5 46284.0 46628.0 46925.3 46957.5 47012.3 9098.6 9134.2 9163.4 9206.3 9231.4 9075.2 9078.5 9184.2 9194.0 9212.0 9206.4 9215.0 9218.4 9235.4 9275.5 9158.2 9184.1 9197.4 9198.1 9211.4 9190.6 9218.9 9235.2 9257.0 9279.1 43370.8 43800.8 44021.6 44039.6 44144.6 3865.0 4067.7 4122.3 4136.2 4366.8 34404.7 34658.1 34683.0 34807.5 34968.5 4632.7 4680.9 4699.1 4701.2 4790.6 340027.0 341816.0 342929.0 343044.0 343307.0 61489.0 61652.0 61733.7 62096.0 62234.4 38788.8 64169.7 64173.7 64314.4 64461.4 16722.7 17357.6 17371.6 17383.2 17411.7 15276.4 15307.7 15363.6 15411.1 15413.5 20214.0 20513.9 20573.9 20578.3 20823.0 7698.5 7752.7 7783.3 7789.7 7842.9 1043.6 1078.1 1108.4 1109.7 1115.1 33662.5 33816.0 34005.8 34092.5 34154.8 1164.6 1166.1 1204.3 1205.4 1212.9 17755.4 17894.7 18012.4 18123.0 18131.1 650431.0 654038.0 659775.0 664648.0 668398.0 62475.0 62847.4 63135.0 63427.0 63678.7 1404.1 1409.5 1450.2 1452.7 1453.3 32483.4 32900.7 33310.7 33580.2 33678.5 53139.7 54026.7 54084.7 54093.5 54101.7 471552.0 472033.0 474551.0 475880.0 476980.0 27504.2 27894.7 28192.4 28251.2 30448.8 52026.7 52149.5 52259.2 52404.5 53575.5 42120.8 43961.3 44183.6 44263.8 45325.5 43304.1 44444.6 44529.1 45690.0 46267.0 43996.0 46882.3 47075.5 47747.3 48140.5 36851.4 39602.4 39879.4 40566.4 40588.8 29805.4 30018.2 30254.2 30713.0 30735.5 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | [#2] jquery.html Cycles:180 Average:28096.33 Median:24452.01 stddev:74921.75 (306.4%) stddev-sans-first:75103.08 04:11:16 INFO - PROCESS | 10284 | Values: 407.3 412.1 431.6 433.3 440.2 19016.0 19552.7 20437.8 20777.7 20807.8 19579.6 19993.5 20035.0 20551.1 20749.8 5319.2 5664.2 5669.1 5697.4 5711.5 5594.7 5792.6 5865.1 5920.8 5925.6 5859.5 5867.9 5871.8 5889.3 5892.1 5860.0 5875.2 5904.5 5913.2 5915.4 5702.9 5725.1 5728.1 5742.4 5752.9 23705.6 24022.6 24192.9 24711.1 24929.5 2405.1 2495.9 2496.8 2557.1 2599.9 9623.5 9913.5 10274.7 13490.3 14065.2 1963.1 2009.2 2014.1 2037.8 2103.8 78628.0 79100.2 80506.6 83809.0 84670.0 11704.0 11745.4 11882.9 11886.9 11963.8 16674.7 16706.8 16740.4 16772.7 16801.2 8558.3 8710.8 8854.2 8876.0 8985.8 8158.2 8286.9 8298.0 8331.3 8454.8 4261.6 4505.5 4921.6 5014.7 5060.6 1990.0 2132.0 2136.4 2173.7 2185.0 988.7 994.7 1017.9 1021.6 1045.7 20418.3 20749.0 20750.9 21089.8 21140.5 1023.6 1058.9 1074.8 1128.6 1130.6 11038.4 11538.5 11666.6 11710.0 11886.0 374606.0 376035.0 380616.0 536008.0 557275.0 62966.4 64660.7 97305.0 103410.0 103726.5 1061.2 1072.6 1095.4 1100.6 1105.9 16112.0 18335.6 18408.2 18753.2 19371.3 32594.2 40048.0 44764.0 45350.1 45367.5 64297.0 64988.0 65066.7 65404.3 65482.3 8229.3 8432.7 8445.2 8596.3 8846.6 11619.1 13651.1 13831.4 13902.9 14013.9 10932.7 11563.9 11649.7 11857.8 12092.5 10848.1 11643.1 11998.5 12004.5 12433.6 10981.7 11043.5 11355.9 11448.1 11750.0 8347.3 8402.0 8434.1 8689.9 8791.9 9424.0 10499.4 10619.2 11282.8 11432.7 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | [#3] mootools.html Cycles:180 Average:6337.71 Median:475.91 stddev:3669.47 (771.0%) stddev-sans-first:3662.24 04:11:16 INFO - PROCESS | 10284 | Values: 1566.6 1573.8 1782.6 1822.0 1883.4 8358.0 9110.7 9188.7 9905.1 9908.2 9273.0 9615.3 9656.5 9669.7 9675.1 2381.5 2416.5 2416.6 2435.2 2435.4 2433.0 2461.0 2524.7 2525.6 2529.8 2472.8 2487.5 2491.5 2519.7 2538.2 2391.6 2408.0 2419.6 2439.0 2448.1 2372.3 2390.8 2400.3 2403.2 2418.1 9712.6 9803.0 9803.8 9807.7 9837.6 5782.4 5784.6 5812.0 5846.5 5847.1 3561.3 3638.3 3640.7 3706.3 3733.4 1105.5 1141.4 1158.6 1160.9 1164.3 13690.5 13795.2 13908.5 13917.1 13961.1 5014.1 5138.2 5144.7 5152.3 5388.7 11485.5 11543.9 11558.8 11629.3 11636.1 5784.0 5807.9 5812.4 5847.0 5849.5 4840.2 5260.4 5277.0 5331.8 5388.0 4467.0 4483.8 4548.2 4556.7 4601.0 1335.7 1380.3 1388.6 1411.9 1412.3 1040.8 1048.7 1049.1 1057.0 1073.5 6333.9 6483.0 6488.4 6603.0 6604.0 473.5 478.3 478.4 487.7 495.7 4334.3 4390.5 4415.0 4432.0 4439.3 11708.2 12198.7 12223.7 12260.4 12274.6 10880.2 11291.4 12175.6 12180.5 12212.4 8945.6 9140.5 9142.3 9151.8 9157.1 6060.2 6167.4 6213.6 6260.3 6285.8 10230.9 10400.6 10518.9 10627.6 10714.9 10612.4 10899.3 11175.4 11200.8 11246.8 8399.4 8850.2 8968.5 9024.9 9270.5 9358.8 9589.3 9615.5 9685.3 9733.6 8427.7 8439.5 8440.2 8493.2 8565.5 8140.9 8297.9 8329.5 8337.3 8515.0 7385.3 7502.2 7578.7 7583.7 7598.4 5344.7 5420.5 5564.6 5611.2 5651.2 5761.7 5859.4 5899.2 5910.3 5926.4 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | [#4] prototype.html Cycles:180 Average:4914.51 Median:5469.28 stddev:1438.21 (26.3%) stddev-sans-first:1400.54 04:11:16 INFO - PROCESS | 10284 | Values: 333.7 343.4 344.0 356.9 359.2 5646.3 5719.2 5846.4 5868.0 5901.4 5664.0 5721.7 5735.8 5741.8 5770.2 4484.7 4524.9 4525.9 4532.8 4539.3 4426.5 4459.9 4464.5 4480.7 4529.0 4398.3 4420.8 4431.5 4431.7 4433.3 4452.2 4459.6 4472.6 4485.8 4515.1 3750.5 3849.4 3875.7 3880.6 3908.4 5601.0 5604.9 5690.2 5697.2 5698.7 5048.2 5098.5 5139.9 5145.1 5152.5 6036.0 6045.5 6053.6 6089.6 6091.5 4273.6 4297.4 4307.9 4315.2 4317.8 6271.3 6314.5 6373.7 6425.2 6438.3 4354.3 4374.3 4386.8 4399.4 4400.0 4392.6 4426.8 4436.8 4442.4 4447.8 4828.6 5079.6 5119.5 5127.9 5128.3 5908.2 6072.3 6084.7 6093.9 6110.8 1507.5 1527.4 1534.1 1539.8 1551.2 944.3 979.9 992.5 992.9 998.2 5221.9 5267.2 5280.6 5287.9 5323.1 5417.6 5431.3 5460.8 5489.3 5528.8 5087.7 5154.2 5263.4 5320.3 5363.5 2933.4 2947.2 2949.6 2954.0 3000.5 5679.2 5692.6 5725.5 5755.9 5771.8 5223.0 5554.6 5567.5 5571.4 5575.4 5621.5 5692.7 5697.9 5734.5 5760.6 5168.7 5462.3 5476.3 5503.6 5532.4 5416.0 5424.9 5427.4 5428.8 5447.6 5689.8 5723.0 5726.7 5765.3 5807.2 4041.2 4048.5 4061.6 4342.7 4345.3 6015.6 6091.5 6204.5 6209.0 6284.9 6107.8 6109.8 6115.8 6126.3 6136.2 6094.7 6115.7 6165.9 6181.7 6194.4 5760.7 6088.7 6103.7 6110.5 6151.8 6223.2 6236.2 6261.6 6266.4 6276.4 5896.3 6001.3 6024.4 6049.8 6065.5 04:11:16 INFO - PROCESS | 10284 | 04:11:16 INFO - PROCESS | 10284 | [#5] yui.html Cycles:180 Average:22278.95 Median:4767.54 stddev:33533.45 (703.4%) stddev-sans-first:33588.83 04:11:16 INFO - PROCESS | 10284 | Values: 825.3 830.7 855.1 886.0 925.0 14711.0 16045.4 16224.9 16312.7 16340.0 15770.8 15975.6 16074.0 16171.0 16176.8 880.4 894.9 901.7 902.1 903.3 880.1 888.1 891.7 895.1 895.2 933.3 933.7 937.8 938.8 941.2 931.6 932.3 932.5 933.0 936.6 687.1 687.8 693.9 694.1 695.0 14358.9 14430.6 14456.2 14475.1 14478.2 14137.6 14144.8 14150.4 14180.6 14191.6 12466.8 12490.4 12654.2 12829.2 12830.9 3943.3 4040.4 4045.7 4058.0 4170.9 59296.4 79486.2 83557.2 83966.0 85588.6 12397.3 12422.1 12494.3 12763.6 12808.6 21651.1 21760.5 21792.2 21803.8 21827.3 8992.0 9494.2 9555.8 9559.1 9611.9 4964.4 5018.6 5124.9 5410.3 5662.3 3523.5 3642.1 3664.1 3666.4 3671.5 641.6 663.5 663.7 664.8 666.0 563.1 604.7 676.6 757.4 766.0 9263.7 9377.8 9575.5 9799.3 10120.6 645.7 648.7 660.5 670.1 683.0 4637.5 4897.6 4965.5 4975.4 4975.8 78306.0 83720.0 90373.0 135379.0 141201.0 120239.0 120250.0 120854.0 123821.0 126608.0 85485.0 103416.0 103568.5 104457.5 104716.0 9263.8 9494.9 9545.4 9680.8 9748.2 56986.4 58345.7 60262.4 60414.7 60444.7 84899.0 90647.0 91652.5 92114.5 95136.0 12110.0 12230.4 12568.4 12685.2 12813.0 13244.4 13363.4 13386.7 13424.8 13448.5 12142.1 12280.3 12451.9 13018.4 13153.4 11874.2 12075.8 12490.3 12598.2 12821.9 11846.6 12226.6 12345.9 12576.6 12745.8 9793.2 9954.8 10179.4 10198.0 10222.6 10426.2 10473.4 10609.8 10619.2 10642.1 04:11:16 INFO - PROCESS | 10284 | -------- Summary: end -------- 04:11:16 INFO - PROCESS | 10284 | 04:11:17 INFO - TEST-INFO | 10284: exit 0 04:11:17 INFO - TEST-OK | dromaeo_css | took 1111157ms 04:11:17 INFO - TEST-START | kraken 04:11:17 INFO - operating with platform_type : linux_ 04:11:17 INFO - Initialising browser for kraken test... 04:11:17 INFO - TEST-INFO | started process 10550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_S23sb/profile http://localhost:57924/getInfo.html) 04:11:21 INFO - PROCESS | 10550 | __metrics Screen width/height:1600/1200 04:11:21 INFO - PROCESS | 10550 | colorDepth:24 04:11:21 INFO - PROCESS | 10550 | Browser inner width/height: 1024/697 04:11:21 INFO - PROCESS | 10550 | __metrics 04:11:22 ERROR - PROCESS | 10550 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:11:23 INFO - TEST-INFO | 10550: exit 0 04:11:23 INFO - Browser initialized. 04:11:23 INFO - Running cycle 1/1 for kraken test... 04:11:23 INFO - TEST-INFO | started process 10677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_S23sb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:35 INFO - PROCESS | 10677 | RSS: Main: 153530368 04:11:35 INFO - PROCESS | 10677 | 04:11:37 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57924/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:38 INFO - PROCESS | 10677 | RSS: Main: 158797824 04:11:38 INFO - PROCESS | 10677 | 04:11:41 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57924/tests/kraken/driver.html?testName=audio-dft) 04:11:41 INFO - PROCESS | 10677 | RSS: Main: 157499392 04:11:41 INFO - PROCESS | 10677 | 04:11:44 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57924/tests/kraken/driver.html?testName=audio-fft) 04:11:45 INFO - PROCESS | 10677 | RSS: Main: 157650944 04:11:45 INFO - PROCESS | 10677 | 04:11:47 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57924/tests/kraken/driver.html?testName=audio-oscillator) 04:11:47 INFO - PROCESS | 10677 | RSS: Main: 157769728 04:11:47 INFO - PROCESS | 10677 | 04:11:50 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:11:50 INFO - PROCESS | 10677 | RSS: Main: 157351936 04:11:50 INFO - PROCESS | 10677 | 04:11:53 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57924/tests/kraken/driver.html?testName=imaging-darkroom) 04:11:54 INFO - PROCESS | 10677 | RSS: Main: 157806592 04:11:54 INFO - PROCESS | 10677 | 04:11:57 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57924/tests/kraken/driver.html?testName=imaging-desaturate) 04:11:58 INFO - PROCESS | 10677 | RSS: Main: 158593024 04:11:58 INFO - PROCESS | 10677 | 04:12:01 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57924/tests/kraken/driver.html?testName=json-parse-financial) 04:12:02 INFO - PROCESS | 10677 | RSS: Main: 158035968 04:12:02 INFO - PROCESS | 10677 | 04:12:03 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:04 INFO - PROCESS | 10677 | RSS: Main: 157855744 04:12:04 INFO - PROCESS | 10677 | 04:12:06 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:06 INFO - PROCESS | 10677 | RSS: Main: 158388224 04:12:06 INFO - PROCESS | 10677 | 04:12:08 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:09 INFO - PROCESS | 10677 | RSS: Main: 157872128 04:12:09 INFO - PROCESS | 10677 | 04:12:11 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:12 INFO - PROCESS | 10677 | RSS: Main: 158171136 04:12:12 INFO - PROCESS | 10677 | 04:12:15 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:15 INFO - PROCESS | 10677 | RSS: Main: 158576640 04:12:15 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | Cycle 1(1): loaded http://localhost:57924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57924/tests/kraken/driver.html?testName=ai-astar) 04:12:17 INFO - PROCESS | 10677 | RSS: Main: 160604160 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | __start_tp_report 04:12:17 INFO - PROCESS | 10677 | _x_x_mozilla_page_load 04:12:17 INFO - PROCESS | 10677 | _x_x_mozilla_page_load_details 04:12:17 INFO - PROCESS | 10677 | |i|pagename|runs| 04:12:17 INFO - PROCESS | 10677 | |0;ai-astar;102;110;112;109;110;112;117;111;113;122 04:12:17 INFO - PROCESS | 10677 | |1;audio-beat-detection;142;114;142;166;117;144;145;118;169;117 04:12:17 INFO - PROCESS | 10677 | |2;audio-dft;161;161;162;160;162;162;159;161;160;161 04:12:17 INFO - PROCESS | 10677 | |3;audio-fft;75;75;77;169;75;75;74;75;169;76 04:12:17 INFO - PROCESS | 10677 | |4;audio-oscillator;85;84;161;84;85;85;147;85;84;151 04:12:17 INFO - PROCESS | 10677 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;118;118 04:12:17 INFO - PROCESS | 10677 | |6;imaging-darkroom;148;149;147;147;148;149;149;147;147;148 04:12:17 INFO - PROCESS | 10677 | |7;imaging-desaturate;95;96;96;95;96;96;95;95;96;96 04:12:17 INFO - PROCESS | 10677 | |8;json-parse-financial;52;51;53;52;52;50;51;52;50;52 04:12:17 INFO - PROCESS | 10677 | |9;json-stringify-tinderbox;59;60;59;60;59;58;59;59;59;59 04:12:17 INFO - PROCESS | 10677 | |10;stanford-crypto-aes;74;76;73;73;73;73;72;73;74;71 04:12:17 INFO - PROCESS | 10677 | |11;stanford-crypto-ccm;119;122;133;121;126;121;119;125;150;123 04:12:17 INFO - PROCESS | 10677 | |12;stanford-crypto-pbkdf2;152;152;154;149;149;157;154;153;149;152 04:12:17 INFO - PROCESS | 10677 | |13;stanford-crypto-sha256-iterative;62;61;66;62;64;61;61;61;61;60 04:12:17 INFO - PROCESS | 10677 | __end_tp_report 04:12:17 INFO - PROCESS | 10677 | __start_cc_report 04:12:17 INFO - PROCESS | 10677 | _x_x_mozilla_cycle_collect,893 04:12:17 INFO - PROCESS | 10677 | __end_cc_report 04:12:17 INFO - PROCESS | 10677 | __startTimestamp1473937937662__endTimestamp 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | ------- Summary: start ------- 04:12:17 INFO - PROCESS | 10677 | Number of tests: 14 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:5.20 (4.6%) stddev-sans-first:4.14 04:12:17 INFO - PROCESS | 10677 | Values: 102.0 110.0 112.0 109.0 110.0 112.0 117.0 111.0 113.0 122.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:143.00 stddev:20.32 (14.2%) stddev-sans-first:21.49 04:12:17 INFO - PROCESS | 10677 | Values: 142.0 114.0 142.0 166.0 117.0 144.0 145.0 118.0 169.0 117.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 04:12:17 INFO - PROCESS | 10677 | Values: 161.0 161.0 162.0 160.0 162.0 162.0 159.0 161.0 160.0 161.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.54 (52.7%) stddev-sans-first:41.33 04:12:17 INFO - PROCESS | 10677 | Values: 75.0 75.0 77.0 169.0 75.0 75.0 74.0 75.0 169.0 76.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:84.50 stddev:33.23 (39.3%) stddev-sans-first:34.44 04:12:17 INFO - PROCESS | 10677 | Values: 85.0 84.0 161.0 84.0 85.0 85.0 147.0 85.0 84.0 151.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:12:17 INFO - PROCESS | 10677 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 04:12:17 INFO - PROCESS | 10677 | Values: 148.0 149.0 147.0 147.0 148.0 149.0 149.0 147.0 147.0 148.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:12:17 INFO - PROCESS | 10677 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 04:12:17 INFO - PROCESS | 10677 | Values: 52.0 51.0 53.0 52.0 52.0 50.0 51.0 52.0 50.0 52.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 04:12:17 INFO - PROCESS | 10677 | Values: 59.0 60.0 59.0 60.0 59.0 58.0 59.0 59.0 59.0 59.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.36 04:12:17 INFO - PROCESS | 10677 | Values: 74.0 76.0 73.0 73.0 73.0 73.0 72.0 73.0 74.0 71.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:124.00 stddev:9.42 (7.6%) stddev-sans-first:9.66 04:12:17 INFO - PROCESS | 10677 | Values: 119.0 122.0 133.0 121.0 126.0 121.0 119.0 125.0 150.0 123.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:152.50 stddev:2.60 (1.7%) stddev-sans-first:2.76 04:12:17 INFO - PROCESS | 10677 | Values: 152.0 152.0 154.0 149.0 149.0 157.0 154.0 153.0 149.0 152.0 04:12:17 INFO - PROCESS | 10677 | 04:12:17 INFO - PROCESS | 10677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.50 stddev:1.79 (2.9%) stddev-sans-first:1.90 04:12:17 INFO - PROCESS | 10677 | Values: 62.0 61.0 66.0 62.0 64.0 61.0 61.0 61.0 61.0 60.0 04:12:17 INFO - PROCESS | 10677 | -------- Summary: end -------- 04:12:17 INFO - PROCESS | 10677 | 04:12:18 INFO - TEST-INFO | 10677: exit 0 04:12:18 INFO - TEST-OK | kraken | took 61125ms 04:12:18 INFO - SUITE-END | took 1172s 04:12:18 INFO - Completed test suite (00:19:32) 04:12:18 INFO - javascript benchmark 04:12:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7656.518149410868, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3322.9833850830746, 3337.2324365395943, 3348.1294863335534, 3362.882299119531, 3375.5949286085674, 5684.204211410401, 5778.971105144468, 5800.738966746496, 5803.854903627412, 5817.272840894888, 5771.971140144294, 5800.216970708953, 5824.0, 5834.27071616048, 5842.707864606774, 5200.037992971303, 5223.764930578114, 5295.338082739658, 5337.439568845273, 5339.919901201485, 5143.228515722634, 5197.974010129944, 5269.235960785683, 5294.761735721882, 5373.7581808818695, 5321.0, 5333.146696528556, 5342.1452567589195, 5358.490943360374, 5367.946320536803, 5344.4922732340365, 5373.140297552392, 5383.380911195223, 5387.919181212285, 5412.9458705412835, 5098.770555325019, 5146.330976973007, 5162.586993040548, 5292.391374991887, 5292.470752924715, 5681.289838770153, 5721.313442386941, 5725.08398656213, 5740.827775166752, 5766.04860198071, 6166.660833654148, 6204.751809927598, 6225.937740622627, 6236.407541283571, 6236.688165591702, 5970.701464926779, 6039.3960603939695, 6082.695865206722, 6256.96871515644, 6266.248050234001, 5697.6296540724725, 5718.513926316268, 5724.1413787931315, 5728.598998070137, 5736.6558006519745, 6258.968705156445, 6268.529860260499, 6275.403836635513, 6279.560430769893, 6282.780102696383, 5951.5238780897425, 6013.0980352946535, 6015.2781666200335, 6016.608920420159, 6025.9397406026255, 6184.474319682788, 6208.534359923024, 6228.252609686867, 6231.875362492816, 6242.219722534684, 6205.441510264098, 6211.534134939898, 6215.06773983897, 6216.875662486725, 6224.595401298901, 6068.605540639845, 6097.634141951497, 6101.481374083164, 6192.380761923771, 6215.440610345091, 4750.572448479585, 4752.619790416758, 4759.785809638574, 4770.7853146607795, 4780.4741478437345, 4237.597428244312, 4239.618434340862, 4244.0, 4247.51153617338, 4270.274053410928, 5866.384029676908, 5887.499562537232, 5894.557908156906, 5970.940290597126, 6013.1581578579035, 6203.2245969253845, 6207.441330280297, 6228.657423841732, 6229.5327850410495, 6263.185785847811, 5947.1376650385455, 5960.880782384328, 5975.551833612496, 5982.46157845796, 6041.486473649701, 5222.947770522323, 5323.387810401776, 5330.92003619946, 5341.0653135701095, 5346.304980352529, 6488.740450381932, 6513.283538810727, 6556.409923106943, 6565.474762019027, 6572.934270657328, 6310.368963103745, 6315.905261421174, 6316.873662526816, 6319.6208227506495, 6320.5891617044745, 6285.120083188449, 6286.497080233662, 6318.494520438446, 6461.450776684034, 6546.541742078009, 6104.603200791934, 6107.786227482017, 6109.20580324555, 6112.755489780537, 6143.293521245114, 6188.535859810622, 6219.346968568235, 6219.564630476004, 6221.782237621662, 6221.813345599639, 5861.912071318849, 6022.367651396716, 6070.605410648471, 6079.270487541523, 6098.512119030378, 6064.636121832704, 6072.180255665428, 6095.847603809941, 6113.174721412553, 6128.540359473147, 5983.9401605983385, 5989.1914591529585, 6034.758609655564, 6037.788677396446, 6038.849028774316, 5926.1999630049395, 5970.0746384310505, 5986.88026239464, 6104.053871649901, 6110.816675499742, 5932.644041357532, 5934.347221805511, 5955.67243801595, 5957.225560677084, 5988.8802223956145], "value": 5718.505048788452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2430839908121, 629.9559030867839, 659.9868002639947, 666.813292278162, 699.1505321034941, 40669.99999999996, 45546.54453455465, 45674.771626141905, 45833.770831145885, 45961.54038459614, 46284.0, 46628.0, 46925.29612055822, 46957.530424695746, 47012.29481557779, 9098.636054557826, 9134.17792398684, 9163.404378715362, 9206.309526785484, 9231.399959002643, 9075.228605568534, 9078.500682462462, 9184.21934135596, 9194.0, 9212.0, 9206.447613143233, 9215.0, 9218.35471516994, 9235.353525253235, 9275.536223188847, 9158.175764181222, 9184.127507886773, 9197.402168859036, 9198.126178013077, 9211.355205135644, 9190.632374705005, 9218.907810921872, 9235.215006724437, 9257.028012058705, 9279.072092790735, 43370.78314608438, 43800.780996094814, 44021.55978440207, 44039.55960440387, 44144.55855441437, 3865.0, 4067.7355971861734, 4122.299209134454, 4136.172765446892, 4366.759828209447, 34404.65595344039, 34658.13354666128, 34683.0, 34807.4778878317, 34968.475472867925, 4632.72203667781, 4680.9297860532115, 4699.103395176727, 4701.247800351962, 4790.592799612037, 340027.0, 341816.0, 342929.0, 343044.0, 343307.0, 61489.0, 61652.0, 61733.69133154395, 62096.0, 62234.37765622376, 38788.80605596954, 64169.679151603945, 64173.67913160404, 64314.35685643084, 64461.35538644553, 16722.74915876263, 17357.56606084858, 17371.56571085733, 17383.217755201047, 17411.73882391765, 15276.388944442098, 15307.693846123015, 15363.61590960235, 15411.075335479907, 15413.460528881435, 20214.0, 20513.89743051305, 20573.89713051425, 20578.27976020832, 20823.0, 7698.498792735475, 7752.728654497066, 7783.338416234684, 7789.715656388963, 7842.921570784333, 1043.598214687351, 1078.1428764132534, 1108.351614305624, 1109.7003808971533, 1115.0967716149944, 33662.49506257408, 33816.0, 34005.829970850486, 34092.48861267083, 34154.829225854206, 1164.55746816211, 1166.1428849795393, 1204.2714157934324, 1205.391277404905, 1212.8969037631723, 17755.378561750276, 17894.731579026324, 18012.36956706535, 18123.0, 18131.093445327682, 650431.0, 654038.0, 659775.0, 664648.0, 668398.0, 62475.0, 62847.37152628507, 63135.0, 63427.0, 63678.681606592596, 1404.1013751199241, 1409.4644035266738, 1450.166154461189, 1452.7021960498284, 1453.302414840861, 32483.35033299368, 32900.67099329072, 33310.66689333173, 33580.160495987795, 33678.49482257719, 53139.734301328244, 54026.72986635042, 54084.72957635186, 54093.45906540884, 54101.72949135229, 471552.0, 472033.0, 474551.0, 475880.0, 476980.0, 27504.17487475379, 27894.721052789213, 28192.43615127727, 28251.15246542607, 30448.84775576108, 52026.73986630043, 52149.47850521598, 52259.21611175912, 52404.47595523996, 53575.46424535705, 42120.78939605282, 43961.34057989069, 44183.55816441923, 44263.778681106385, 45325.54674453345, 43304.133917322106, 44444.55555444404, 44529.10941781211, 45690.0, 46267.0, 43996.0, 46882.296765547864, 47075.52924470711, 47747.28379074386, 48140.518594813606, 36851.447228292134, 39602.405963911144, 39879.40180897347, 40566.39150412687, 40588.79705601453, 29805.403891922473, 30018.24954376158, 30254.243643909078, 30713.0, 30735.538966915963], "value": 21495.899152809943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.27098493696286, 412.1386302627508, 431.62879923265984, 433.25480174100545, 440.21861196376426, 19015.954122523257, 19552.706709399354, 20437.795622043795, 20777.688334674993, 20807.791922080774, 19579.608407831834, 19993.500162495944, 20035.0, 20551.075201615924, 20749.792502074975, 5319.175527793198, 5664.178694089354, 5669.121286200645, 5697.373288938214, 5711.543076553887, 5594.748236329375, 5792.565557583177, 5865.120231965218, 5920.792772252972, 5925.585209035369, 5859.472647461727, 5867.88264234715, 5871.794487192949, 5889.293284805829, 5892.057270836667, 5859.970700146515, 5875.177475153482, 5904.498117659982, 5913.172155898178, 5915.40845915405, 5702.942970570282, 5725.083986562172, 5728.083506638959, 5742.425757424266, 5752.884942301131, 23705.644415333783, 24022.639660404933, 24192.87903560471, 24711.135110271054, 24929.501409971697, 2405.074046492113, 2495.8502489850484, 2496.8252222344445, 2557.130575604285, 2599.8700064996674, 9623.470709110996, 9913.504324783731, 10274.691759247235, 13490.325483725774, 14065.156090634595, 1963.0675429171172, 2009.1661960286463, 2014.0533949043927, 2037.7758446570865, 2103.758067822205, 78628.0, 79100.20899790985, 80506.59746701288, 83809.0, 84670.0, 11704.0, 11745.354005529607, 11882.88117118835, 11886.940565297118, 11963.76072478563, 16674.66650667004, 16706.83293167077, 16740.414085507193, 16772.664546709242, 16801.15994200285, 8558.315334773204, 8710.782230444289, 8854.24738897188, 8875.955620221857, 8985.775355616162, 8158.224968627971, 8286.875696864552, 8297.962754655668, 8331.33349332052, 8454.830903381899, 4261.595148460891, 4505.459344878635, 4921.557059864629, 5014.674046186986, 5060.5698515625845, 1990.0398107863743, 2132.0, 2136.44452442363, 2173.7282839645045, 2184.9890750546465, 988.6885631026204, 994.7314225159166, 1017.862588550551, 1021.6424251511911, 1045.6761292057247, 20418.285360012327, 20748.962551872344, 20750.896245518677, 21089.78910210909, 21140.47148821292, 1023.6417253961054, 1058.9258751887294, 1074.7742973975396, 1128.5937062657438, 1130.559081958037, 11038.392888391216, 11538.480768365444, 11666.591669291534, 11710.0, 11886.0, 374606.0, 376035.0, 380616.0, 536008.0, 557275.0, 62966.37033629605, 64660.67669661622, 97305.0, 103410.0, 103726.48136759418, 1061.1722856172198, 1072.56025029739, 1095.370162156763, 1100.5982816272003, 1105.9225854190129, 16112.033278003357, 18335.633287333912, 18408.171632276848, 18753.249870005046, 19371.3220037298, 32594.185145371557, 40048.0, 44764.0, 45350.09299814051, 45367.546324536335, 64297.0, 64988.0, 65066.674666626364, 65404.34595654173, 65482.345176549534, 8229.25936665703, 8432.747017589481, 8445.239928406472, 8596.312295016509, 8846.557672116498, 11619.0704743622, 13651.11267767592, 13831.377588008363, 13902.86097139056, 14013.859861401255, 10932.726681832699, 11563.942180289045, 11649.708757281136, 11857.762844742885, 12092.45583948742, 10848.132149428184, 11643.068554515788, 11998.520059197883, 12004.519819207135, 12433.626991189916, 10981.725456863642, 11043.503042362952, 11355.886441135483, 11448.141389395994, 11750.0, 8347.290480309242, 8402.0, 8434.114417986024, 8689.8696519551, 8791.912080879109, 9423.952880235554, 10499.370037797757, 10619.1504679627, 11282.774344513227, 11432.657020289405], "value": 9513.30941544735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.577024203465, 1573.8032745906762, 1782.5828466369244, 1821.9726704099448, 1883.387898932847, 8357.958210208955, 9110.726678199657, 9188.678396256133, 9905.108540231378, 9908.15780658644, 9272.953635231814, 9615.326927115104, 9656.468894210815, 9669.70990870275, 9675.08086731761, 2381.4522659788217, 2416.492536567323, 2416.5891798394314, 2435.1598698449006, 2435.3789783605157, 2432.9878350608224, 2460.9753902461016, 2524.7222805491383, 2525.6337831014494, 2529.8229123961332, 2472.777450029497, 2487.465194983078, 2491.451880586277, 2519.685039370079, 2538.2385284414695, 2391.5695174868515, 2407.987960060197, 2419.588669926108, 2439.0487709793197, 2448.0697335012583, 2372.264597974616, 2390.768754091644, 2400.279916025203, 2403.230966090852, 2418.0690434182966, 9712.562934667956, 9803.0, 9803.754906127333, 9807.705768826947, 9837.55730992107, 5782.392848750905, 5784.595078344518, 5811.970940145272, 5846.50304724099, 5847.093700476433, 3561.269939662363, 3638.272345530904, 3640.6541378568995, 3706.2772759311947, 3733.4026555750947, 1105.4528008635696, 1141.3876662875196, 1158.6292386436344, 1160.9071274298035, 1164.3072371938683, 13690.52083177094, 13795.2412617306, 13908.51320203788, 13917.095388799695, 13961.092528985584, 5014.122528557488, 5138.152204886152, 5144.6913185209005, 5152.252923326097, 5388.703621300866, 11485.540578376771, 11543.88456115445, 11558.768824623461, 11629.302241865515, 11636.12729045325, 5784.0, 5807.854803629859, 5812.418758124154, 5846.970765146232, 5849.5027922626205, 4840.15297322967, 5260.421353651095, 5277.0, 5331.786728530893, 5388.0, 4466.955330446719, 4483.820647174141, 4548.181327361107, 4556.70381425213, 4601.033782905561, 1335.6660834791303, 1380.3098450774612, 1388.597306781022, 1411.865872742088, 1412.3220853989937, 1040.7814358984547, 1048.6539441984128, 1049.1082579807255, 1056.9524371403306, 1073.538378497238, 6333.904991425133, 6483.0, 6488.448481878999, 6603.0, 6604.0, 473.5430309751107, 478.27063727814664, 478.394830539368, 487.7000644603543, 495.72982724415283, 4334.349847522833, 4390.517043125254, 4414.9558504414545, 4431.955680443219, 4439.311906654474, 11708.238964467282, 12198.695032624255, 12223.69440763988, 12260.386980650932, 12274.631761047183, 10880.183986201067, 11291.435428228555, 12175.573854915036, 12180.512779488721, 12212.389380530938, 8945.552722363856, 9140.542972851465, 9142.268618510503, 9151.771205719777, 9157.130072643089, 6060.2424696912885, 6167.414095660905, 6213.565050446426, 6260.342664020394, 6285.779997700241, 10230.948845255725, 10400.635977741045, 10518.947405262925, 10627.628033018807, 10714.946425267824, 10612.416317102634, 10899.29154604948, 11175.441227938732, 11200.775984480428, 11246.775064498828, 8399.41204115706, 8850.247728942855, 8968.461892286483, 9024.909750902407, 9270.490123043297, 9358.766030849283, 9589.280803939871, 9615.51922403863, 9685.273604479833, 9733.561989710339, 8427.662893484192, 8439.451435656663, 8440.155984401756, 8493.235608795238, 8565.48607083577, 8140.87788683182, 8297.875531867148, 8329.541875196923, 8337.333013358795, 8515.0, 7385.335319821027, 7502.212267711811, 7578.734744283924, 7583.658735357032, 7598.430117741081, 5344.732763361894, 5420.53925416344, 5564.610477266714, 5611.158326250932, 5651.237082993907, 5761.683107429131, 5859.44335288147, 5899.174115623902, 5910.320313164041, 5926.436988486087], "value": 4950.184754587708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.7380156577087, 343.4041937238891, 343.958605675317, 356.8536899871053, 359.1900264902644, 5646.2659854219, 5719.170720245573, 5846.444587764161, 5868.031774757165, 5901.350851406347, 5664.0, 5721.656700597967, 5735.824156048011, 5741.799037033705, 5770.19217309577, 4484.708493947883, 4524.886877828048, 4525.932111018321, 4532.796024178903, 4539.3417954396755, 4426.468823741139, 4459.910801783963, 4464.508904020555, 4480.7087539310005, 4529.0, 4398.296272596385, 4420.756858372788, 4431.534688857656, 4431.7340959542535, 4433.290673492242, 4452.1986042512335, 4459.576340247671, 4472.575105364985, 4485.798139083749, 4515.119551687422, 3750.5499340079364, 3849.4418309344987, 3875.7093218008763, 3880.5925377835483, 3908.355121404965, 5601.0, 5604.915926261109, 5690.231818704505, 5697.230873832021, 5698.658080515141, 5048.217526283432, 5098.541131298164, 5139.922901156486, 5145.099607568661, 5152.484751524855, 6035.969820150915, 6045.486133678643, 6053.576249662526, 6089.6041757286075, 6091.543134264948, 4273.572642735701, 4297.35539669049, 4307.935380969288, 4315.180115777992, 4317.827286908519, 6271.341509141565, 6314.494840412756, 6373.713182906734, 6425.22897252328, 6438.323975982501, 4354.346847972766, 4374.343848422698, 4386.815559798836, 4399.406080179199, 4400.0, 4392.604665580113, 4426.778661066934, 4436.800343984529, 4442.444694413199, 4447.799849006802, 4828.637852161102, 5079.568236699848, 5119.488051194925, 5127.948720512822, 5128.282040514331, 5908.20239267702, 6072.271327440735, 6084.69576521181, 6093.908591371133, 6110.847228819315, 1507.4723846653803, 1527.427214794452, 1534.0795522686299, 1539.815222173324, 1551.224387806097, 944.2729098594044, 979.9167070799062, 992.4938281476499, 992.9056739609725, 998.2064258914036, 5221.921671174935, 5267.207610520496, 5280.6303558750515, 5287.867803304871, 5323.148296272578, 5417.566594672417, 5431.321084864392, 5460.771326451517, 5489.258950041693, 5528.75120619573, 5087.694738315713, 5154.226865970059, 5263.394709608444, 5320.255164277004, 5363.517283444508, 2933.4426458972725, 2947.233719232972, 2949.5694588124743, 2953.985230073879, 3000.5199168132995, 5679.2333035040565, 5692.57305702074, 5725.51333136688, 5755.884882302415, 5771.835561664376, 5223.0, 5554.611177217556, 5567.526760225345, 5571.387147413781, 5575.4424557544735, 5621.522170615462, 5692.715364231772, 5697.943020569741, 5734.541236701054, 5760.567957403212, 5168.741562921914, 5462.289902312674, 5476.274973383372, 5503.614746967673, 5532.391436942014, 5416.025115479251, 5424.860779236246, 5427.402985671652, 5428.755705993319, 5447.618666693294, 5689.829305120853, 5723.0, 5726.685032323262, 5765.321158658634, 5807.245058142415, 4041.1715598302867, 4048.5344185417875, 4061.5532291447325, 4342.717723347972, 4345.261305578122, 6015.608985415934, 6091.5126789857595, 6204.5036397089025, 6209.0, 6284.937150628435, 6107.816765497042, 6109.7861574844665, 6115.816525504242, 6126.326104128631, 6136.171616831849, 6094.7257373417415, 6115.694215289307, 6165.938340616716, 6181.660008699565, 6194.420422792159, 5760.683162426107, 6088.695565221809, 6103.7253323601435, 6110.541709371903, 6151.81610528256, 6223.222097237845, 6236.220472440945, 6261.622443062519, 6266.373362663697, 6276.403741644536, 5896.321922978912, 6001.279846418458, 6024.3975602439405, 6049.78825741097, 6065.4541091300225], "value": 4454.911842506642, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.2902503846694, 830.6594296338499, 855.0807881527357, 885.9512726800025, 924.9861252081216, 14711.0, 16045.438409655664, 16224.918875405607, 16312.673746525063, 16340.0, 15770.84229157708, 15975.600609984756, 16074.0, 16171.0, 16176.83823161768, 880.3617377401381, 894.9418287811271, 901.6573701993234, 902.1204325782376, 903.3134817538652, 880.0847118996236, 888.1340692824476, 891.692366133686, 895.1317222294364, 895.1898531828706, 933.3466573398614, 933.7198840347869, 937.8124375124968, 938.7653086728318, 941.232895190421, 931.6273490603779, 932.2588542109006, 932.5383934952242, 933.0063482391299, 936.6206686292063, 687.0552989639247, 687.7592842505134, 693.8681650486442, 694.0664805836142, 695.0130814243786, 14358.92820535901, 14430.567082987527, 14456.204908730017, 14475.131492110508, 14478.203698796562, 14137.646558836008, 14144.787828182585, 14150.363233654407, 14180.57458276243, 14191.645208869757, 12466.81299780504, 12490.43793029316, 12654.240745555297, 12829.166104203197, 12830.935845320713, 3943.3493473576827, 4040.4141399497203, 4045.7167998240134, 4057.9594204057876, 4170.874873753793, 59296.40703592952, 79486.15415375422, 83557.16442835494, 83966.0, 85588.57205713994, 12397.318147501794, 12422.130450868533, 12494.312812795202, 12763.596004439505, 12808.615741527768, 21651.13395464195, 21760.45598860041, 21792.237271695416, 21803.781962180492, 21827.345179644635, 8992.0, 9494.192993595483, 9555.761105972268, 9559.091886270793, 9611.855822162674, 4964.379452568429, 5018.573421259161, 5124.897502049938, 5410.296661434067, 5662.292213473316, 3523.489094081344, 3642.1440961374055, 3664.1022949377575, 3666.431703086026, 3671.504346913186, 641.5701480008405, 663.4592806862391, 663.6747993483255, 664.833791552112, 666.044226534924, 563.107474652672, 604.7067172421372, 676.6041865508635, 757.360030773995, 766.0389403128011, 9263.722088337361, 9377.812443751087, 9575.521223938775, 9799.265055120895, 10120.645777397756, 645.7094307561522, 648.6562122075308, 660.4716227018366, 670.0819876768858, 683.0, 4637.5130611286, 4897.576636804576, 4965.453800081988, 4975.402951645826, 4975.802400362097, 78306.0, 83720.0, 90373.0, 135379.0, 141201.0, 120239.0, 120250.0, 120854.0, 123821.0, 126608.0, 85485.0, 103416.0, 103568.48215759023, 104457.47771261095, 104716.0, 9263.76840578991, 9494.90505094968, 9545.427274363283, 9680.75798105053, 9748.184381941095, 56986.43013569977, 58345.708271458374, 60262.39737602568, 60414.69792651009, 60444.69777651084, 84899.0, 90647.0, 91652.54173729089, 92114.53942730243, 95136.0, 12110.0, 12230.388480576114, 12568.434420451285, 12685.175463594836, 12813.0, 13244.404001820134, 13363.39864706071, 13386.665333366744, 13424.798628020782, 13448.520662726896, 12142.089343299465, 12280.26318420862, 12451.937740311241, 13018.414171362501, 13153.408096635865, 11874.168808183344, 12075.75848483043, 12490.250584964931, 12598.244105353708, 12821.871781282067, 11846.585369512026, 12226.633201003984, 12345.876541234473, 12576.622701318975, 12745.808812867628, 9793.167580755715, 9954.751131221778, 10179.389236645826, 10198.0, 10222.6422075227, 10426.218033647356, 10473.371597704163, 10609.840852387066, 10619.1504679627, 10642.095421888916], "value": 7811.156748369976, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 112.0, 109.0, 110.0, 112.0, 117.0, 111.0, 113.0, 122.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 142.0, 166.0, 117.0, 144.0, 145.0, 118.0, 169.0, 117.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 162.0, 162.0, 159.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 169.0, 75.0, 75.0, 74.0, 75.0, 169.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 161.0, 84.0, 85.0, 85.0, 147.0, 85.0, 84.0, 151.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 149.0, 149.0, 147.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 52.0, 52.0, 50.0, 51.0, 52.0, 50.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 73.0, 73.0, 73.0, 72.0, 73.0, 74.0, 71.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 133.0, 121.0, 126.0, 121.0, 119.0, 125.0, 150.0, 123.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 154.0, 149.0, 149.0, 157.0, 154.0, 153.0, 149.0, 152.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 66.0, 62.0, 64.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 61.9, "unit": "score"}]}]} 04:12:18 INFO - Return code: 0 04:12:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:18 ERROR - # TBPL SUCCESS # 04:12:18 INFO - Running post-action listener: _resource_record_post_action 04:12:18 INFO - [mozharness: 2016-09-15 11:12:18.951649Z] Finished run-tests step (success) 04:12:18 INFO - Running post-run listener: _resource_record_post_run 04:12:19 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 327987200; Read time: 28; Write time: 189468 04:12:19 INFO - TinderboxPrint: CPU usage
13.3% 04:12:19 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 04:12:19 INFO - TinderboxPrint: I/O write bytes / time
327,987,200 / 189,468 04:12:19 INFO - TinderboxPrint: CPU idle
8,223.0 (86.7%) 04:12:19 INFO - TinderboxPrint: CPU user
1,205.0 (12.7%) 04:12:19 INFO - TinderboxPrint: Swap in / out
0 / 0 04:12:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77156352; Read time: 0; Write time: 60564 04:12:19 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248291328; Read time: 28; Write time: 128652 04:12:19 INFO - Running post-run listener: _upload_blobber_files 04:12:19 INFO - Blob upload gear active. 04:12:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:19 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 04:12:19 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'] 04:12:19 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 04:12:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:24 INFO - (blobuploader) - INFO - Done attempting. 04:12:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:12:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:25 INFO - (blobuploader) - INFO - Done attempting. 04:12:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:12:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:12:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:25 INFO - (blobuploader) - INFO - Done attempting. 04:12:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:25 INFO - Return code: 0 04:12:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/375b77929e12f8e6366c81021d590402f2e0f0d4411062164099cd62cc2efefd11655f196147e2120b2c2ff3845670af99d1063dba2206aa05d7a6e05801eb8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e059dc5003c4fe60c9bc39c5a55cecaf110552683ca2776934027414b58a2e3e650d568cf2a56918cd6ae6044f1a5dd824e6e3cb0db90a5ceeb9e0b15205d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6166e37a0c1ea66f3c0df1a87293520889caa521ddc88136fbbab7b60049bfe31d61046b24fd50142a1ae2659f569a6657a4e6962b486f42953f9dc4682c7900"} 04:12:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:25 INFO - Contents: 04:12:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/375b77929e12f8e6366c81021d590402f2e0f0d4411062164099cd62cc2efefd11655f196147e2120b2c2ff3845670af99d1063dba2206aa05d7a6e05801eb8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e059dc5003c4fe60c9bc39c5a55cecaf110552683ca2776934027414b58a2e3e650d568cf2a56918cd6ae6044f1a5dd824e6e3cb0db90a5ceeb9e0b15205d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6166e37a0c1ea66f3c0df1a87293520889caa521ddc88136fbbab7b60049bfe31d61046b24fd50142a1ae2659f569a6657a4e6962b486f42953f9dc4682c7900"} 04:12:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:25 INFO - Copying logs to upload dir... 04:12:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.386449 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-15 04:12:25.874428) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-15 04:12:25.879060) ========= 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=cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701 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/375b77929e12f8e6366c81021d590402f2e0f0d4411062164099cd62cc2efefd11655f196147e2120b2c2ff3845670af99d1063dba2206aa05d7a6e05801eb8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e059dc5003c4fe60c9bc39c5a55cecaf110552683ca2776934027414b58a2e3e650d568cf2a56918cd6ae6044f1a5dd824e6e3cb0db90a5ceeb9e0b15205d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6166e37a0c1ea66f3c0df1a87293520889caa521ddc88136fbbab7b60049bfe31d61046b24fd50142a1ae2659f569a6657a4e6962b486f42953f9dc4682c7900"} build_url:https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/Zc-6LWTXTEO4EUa3TFp_xA/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/375b77929e12f8e6366c81021d590402f2e0f0d4411062164099cd62cc2efefd11655f196147e2120b2c2ff3845670af99d1063dba2206aa05d7a6e05801eb8e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67e059dc5003c4fe60c9bc39c5a55cecaf110552683ca2776934027414b58a2e3e650d568cf2a56918cd6ae6044f1a5dd824e6e3cb0db90a5ceeb9e0b15205d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6166e37a0c1ea66f3c0df1a87293520889caa521ddc88136fbbab7b60049bfe31d61046b24fd50142a1ae2659f569a6657a4e6962b486f42953f9dc4682c7900"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-15 04:12:25.912822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-15 04:12:25.913169) ========= 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=cbe409c6de289db6ac707de3000001d4-1473936266.542065-1237728701 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-15 04:12:25.991404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-15 04:12:25.994757) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-15 04:12:25.995054) ========= ========= Total master_lag: 0.18 =========