builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1476138643.09 results: success (0) buildid: 20161010134924 builduid: cc867e14f0c5448e96940b3b23d763fc revision: b35318b86b335200340aad6893828b99c187ad84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.088599) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.089127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.089433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.105092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.105712) ========= 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=62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 15:30:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2016-10-10 15:30:44 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111596 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.232518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.232858) ========= 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=62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014242 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.282519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.282944) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b35318b86b335200340aad6893828b99c187ad84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b35318b86b335200340aad6893828b99c187ad84 --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=62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 15:30:44,181 truncating revision to first 12 chars 2016-10-10 15:30:44,181 Setting DEBUG logging. 2016-10-10 15:30:44,181 attempt 1/10 2016-10-10 15:30:44,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b35318b86b33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 15:30:44,469 unpacking tar archive at: mozilla-beta-b35318b86b33/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.916966) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.917281) ========= script_repo_revision: b35318b86b335200340aad6893828b99c187ad84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.917683) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.917948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 15:30:43.925883) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-10-10 15:30:43.926239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:44 INFO - MultiFileLogger online at 20161010 15:30:44 in /builds/slave/test 15:30:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:30:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:44 INFO - {'append_to_log': False, 15:30:44 INFO - 'base_work_dir': '/builds/slave/test', 15:30:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:30:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:44 INFO - 'branch': 'Mozilla-Beta', 15:30:44 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:44 INFO - 'config_files': ('talos/linux_config.py',), 15:30:44 INFO - 'default_actions': ('clobber', 15:30:44 INFO - 'read-buildbot-config', 15:30:44 INFO - 'download-and-extract', 15:30:44 INFO - 'populate-webroot', 15:30:44 INFO - 'create-virtualenv', 15:30:44 INFO - 'install', 15:30:44 INFO - 'run-tests'), 15:30:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:44 INFO - 'download_minidump_stackwalk': True, 15:30:44 INFO - 'download_symbols': 'ondemand', 15:30:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:44 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:44 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:44 INFO - 'installer_path': 'installer.exe', 15:30:44 INFO - 'log_level': 'info', 15:30:44 INFO - 'log_name': 'talos', 15:30:44 INFO - 'log_to_console': True, 15:30:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:44 INFO - 'opt_config_files': (), 15:30:44 INFO - 'pip_index': False, 15:30:44 INFO - 'sps_profile': False, 15:30:44 INFO - 'sps_profile_interval': 0, 15:30:44 INFO - 'suite': 'dromaeojs-e10s', 15:30:44 INFO - 'system_bits': '32', 15:30:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:44 INFO - 'title': 'talos-linux64-ix-018', 15:30:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:44 INFO - 'use_talos_json': True, 15:30:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:44 INFO - 'work_dir': 'build'} 15:30:44 INFO - [mozharness: 2016-10-10 22:30:44.915982Z] Running clobber step. 15:30:44 INFO - Running pre-action listener: _resource_record_pre_action 15:30:44 INFO - Running main action method: clobber 15:30:44 INFO - rmtree: /builds/slave/test/build 15:30:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:45 INFO - Running post-action listener: _resource_record_post_action 15:30:45 INFO - [mozharness: 2016-10-10 22:30:45.381898Z] Finished clobber step (success) 15:30:45 INFO - [mozharness: 2016-10-10 22:30:45.381998Z] Running read-buildbot-config step. 15:30:45 INFO - Running pre-action listener: _resource_record_pre_action 15:30:45 INFO - Running main action method: read_buildbot_config 15:30:45 INFO - Using buildbot properties: 15:30:45 INFO - { 15:30:45 INFO - "project": "", 15:30:45 INFO - "product": "firefox", 15:30:45 INFO - "script_repo_revision": "production", 15:30:45 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:30:45 INFO - "repository": "", 15:30:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:30:45 INFO - "buildid": "20161010134924", 15:30:45 INFO - "pgo_build": "True", 15:30:45 INFO - "basedir": "/builds/slave/test", 15:30:45 INFO - "buildnumber": 146, 15:30:45 INFO - "slavename": "talos-linux64-ix-018", 15:30:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:30:45 INFO - "platform": "ubuntu64_hw", 15:30:45 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:30:45 INFO - "branch": "mozilla-beta", 15:30:45 INFO - "repo_path": "releases/mozilla-beta", 15:30:45 INFO - "revision": "b35318b86b335200340aad6893828b99c187ad84", 15:30:45 INFO - "stage_platform": "linux64-pgo", 15:30:45 INFO - "builduid": "cc867e14f0c5448e96940b3b23d763fc", 15:30:45 INFO - "slavebuilddir": "test" 15:30:45 INFO - } 15:30:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 15:30:45 INFO - Running post-action listener: _resource_record_post_action 15:30:45 INFO - [mozharness: 2016-10-10 22:30:45.384549Z] Finished read-buildbot-config step (success) 15:30:45 INFO - [mozharness: 2016-10-10 22:30:45.384639Z] Running download-and-extract step. 15:30:45 INFO - Running pre-action listener: _resource_record_pre_action 15:30:45 INFO - Running main action method: download_and_extract 15:30:45 INFO - mkdir: /builds/slave/test/build/tests 15:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:45 INFO - https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:30:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:30:45 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:30:45 INFO - retry: Failed, sleeping 30 seconds before retrying 15:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 15:31:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:31:15 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:31:15 INFO - retry: Failed, sleeping 60 seconds before retrying 15:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 15:32:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:32:15 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:32:15 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 15:32:15 INFO - Caught exception: HTTP Error 404: Not Found 15:32:15 INFO - Caught exception: HTTP Error 404: Not Found 15:32:15 INFO - Caught exception: HTTP Error 404: Not Found 15:32:15 INFO - trying https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:32:15 INFO - Downloading https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:32:16 INFO - Downloaded 1327 bytes. 15:32:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:32:16 INFO - Using the following test package requirements: 15:32:16 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:32:16 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:32:16 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 15:32:16 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'jsshell-linux-x86_64.zip'], 15:32:16 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:32:16 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:32:16 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 15:32:16 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 15:32:16 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:32:16 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:32:16 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:32:16 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:16 INFO - https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:32:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:32:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:32:16 INFO - retry: Failed, sleeping 30 seconds before retrying 15:32:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 15:32:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:32:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:32:46 INFO - retry: Failed, sleeping 60 seconds before retrying 15:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 15:33:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:33:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:33:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 15:33:46 INFO - Caught exception: HTTP Error 404: Not Found 15:33:46 INFO - Caught exception: HTTP Error 404: Not Found 15:33:46 INFO - Caught exception: HTTP Error 404: Not Found 15:33:46 INFO - trying https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:33:46 INFO - Downloading https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:47 INFO - Downloaded 21842734 bytes. 15:33:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:33:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:33:48 INFO - Return code: 0 15:33:48 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:48 INFO - https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:33:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:33:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:33:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:33:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:33:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:33:48 INFO - retry: Failed, sleeping 30 seconds before retrying 15:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 15:34:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:34:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:34:18 INFO - retry: Failed, sleeping 60 seconds before retrying 15:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 15:35:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:35:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:35:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 15:35:18 INFO - Caught exception: HTTP Error 404: Not Found 15:35:18 INFO - Caught exception: HTTP Error 404: Not Found 15:35:18 INFO - Caught exception: HTTP Error 404: Not Found 15:35:18 INFO - trying https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:35:18 INFO - Downloading https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:35:19 INFO - Downloaded 21842734 bytes. 15:35:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:35:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:35:20 INFO - Return code: 0 15:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:20 INFO - https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:35:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:35:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:35:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:35:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:35:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:35:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:35:20 INFO - retry: Failed, sleeping 30 seconds before retrying 15:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 15:35:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:35:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:35:50 INFO - retry: Failed, sleeping 60 seconds before retrying 15:36:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 15:36:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:36:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:36:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 15:36:50 INFO - Caught exception: HTTP Error 404: Not Found 15:36:50 INFO - Caught exception: HTTP Error 404: Not Found 15:36:50 INFO - Caught exception: HTTP Error 404: Not Found 15:36:50 INFO - trying https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:36:50 INFO - Downloading https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:36:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:36:51 INFO - Downloaded 14413740 bytes. 15:36:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:36:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:36:51 INFO - Return code: 0 15:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:51 INFO - https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:36:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:36:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:36:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:36:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:36:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:36:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:36:51 INFO - retry: Failed, sleeping 30 seconds before retrying 15:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 15:37:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:37:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:37:21 INFO - retry: Failed, sleeping 60 seconds before retrying 15:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 15:38:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:38:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:38:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 15:38:21 INFO - Caught exception: HTTP Error 404: Not Found 15:38:21 INFO - Caught exception: HTTP Error 404: Not Found 15:38:21 INFO - Caught exception: HTTP Error 404: Not Found 15:38:21 INFO - trying https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:38:21 INFO - Downloading https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:38:22 INFO - Downloaded 56792205 bytes. 15:38:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:38:22 INFO - mkdir: /builds/slave/test/properties 15:38:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:38:22 INFO - Writing to file /builds/slave/test/properties/build_url 15:38:22 INFO - Contents: 15:38:22 INFO - build_url:https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:38:23 INFO - Running post-action listener: _resource_record_post_action 15:38:23 INFO - Running post-action listener: set_extra_try_arguments 15:38:23 INFO - [mozharness: 2016-10-10 22:38:23.565834Z] Finished download-and-extract step (success) 15:38:23 INFO - [mozharness: 2016-10-10 22:38:23.566070Z] Running populate-webroot step. 15:38:23 INFO - Running pre-action listener: _resource_record_pre_action 15:38:23 INFO - Running main action method: populate_webroot 15:38:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:38:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:38:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:38:23 INFO - '--tppagecycles', 15:38:23 INFO - '7'], 15:38:23 INFO - 'tests': ['tsvgm']}}, 15:38:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:38:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:38:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:38:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:38:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['damp', 'tps']}, 15:38:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'tests': ['damp', 'tps']}, 15:38:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['dromaeo_dom']}, 15:38:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:38:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['basic_compositor_video']}, 15:38:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:38:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['a11yr', 15:38:23 INFO - 'ts_paint', 15:38:23 INFO - 'tpaint', 15:38:23 INFO - 'sessionrestore', 15:38:23 INFO - 'sessionrestore_no_auto_restore', 15:38:23 INFO - 'tabpaint']}, 15:38:23 INFO - 'other-e10s': {'tests': ['a11yr', 15:38:23 INFO - 'ts_paint', 15:38:23 INFO - 'tpaint', 15:38:23 INFO - 'sessionrestore', 15:38:23 INFO - 'sessionrestore_no_auto_restore', 15:38:23 INFO - 'tabpaint']}, 15:38:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:38:23 INFO - 'ts_paint', 15:38:23 INFO - 'tpaint', 15:38:23 INFO - 'sessionrestore', 15:38:23 INFO - 'sessionrestore_no_auto_restore', 15:38:23 INFO - 'tabpaint']}, 15:38:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:38:23 INFO - 'ts_paint', 15:38:23 INFO - 'tpaint', 15:38:23 INFO - 'sessionrestore', 15:38:23 INFO - 'sessionrestore_no_auto_restore', 15:38:23 INFO - 'tabpaint']}, 15:38:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['a11yr', 15:38:23 INFO - 'ts_paint', 15:38:23 INFO - 'tpaint', 15:38:23 INFO - 'sessionrestore', 15:38:23 INFO - 'sessionrestore_no_auto_restore', 15:38:23 INFO - 'tabpaint']}, 15:38:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['a11yr', 15:38:23 INFO - 'ts_paint', 15:38:23 INFO - 'tpaint', 15:38:23 INFO - 'sessionrestore', 15:38:23 INFO - 'sessionrestore_no_auto_restore', 15:38:23 INFO - 'tabpaint']}, 15:38:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['tsvgx', 15:38:23 INFO - 'tsvgr_opacity', 15:38:23 INFO - 'tart', 15:38:23 INFO - 'tscrollx', 15:38:23 INFO - 'cart']}, 15:38:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:38:23 INFO - 'tsvgr_opacity', 15:38:23 INFO - 'tart', 15:38:23 INFO - 'tscrollx', 15:38:23 INFO - 'cart']}, 15:38:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'talos_options': ['--disable-e10s'], 15:38:23 INFO - 'tests': ['tp5o']}, 15:38:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'tests': ['tp5o']}, 15:38:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'talos_options': ['--disable-e10s', 15:38:23 INFO - '--xperf_path', 15:38:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:23 INFO - 'tests': ['tp5n']}, 15:38:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:23 INFO - 'talos_options': ['--xperf_path', 15:38:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:23 INFO - 'tests': ['tp5n']}}, 15:38:23 INFO - 'talos.zip': {'path': '', 15:38:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:38:23 INFO - Running post-action listener: _resource_record_post_action 15:38:23 INFO - [mozharness: 2016-10-10 22:38:23.587643Z] Finished populate-webroot step (success) 15:38:23 INFO - [mozharness: 2016-10-10 22:38:23.587734Z] Running create-virtualenv step. 15:38:23 INFO - Running pre-action listener: _resource_record_pre_action 15:38:23 INFO - Running main action method: create_virtualenv 15:38:23 INFO - Creating virtualenv /builds/slave/test/build/venv 15:38:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:38:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:38:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:38:23 INFO - Using real prefix '/usr' 15:38:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:38:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:38:26 INFO - Installing pip.................done. 15:38:26 INFO - Return code: 0 15:38:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:38:26 INFO - Using env: {'DISPLAY': ':0', 15:38:26 INFO - 'HOME': '/home/cltbld', 15:38:26 INFO - 'LANG': 'en_US.UTF-8', 15:38:26 INFO - 'LANGUAGE': 'en_US:en', 15:38:26 INFO - 'LOGNAME': 'cltbld', 15:38:26 INFO - 'MAIL': '/var/mail/cltbld', 15:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:26 INFO - 'MOZ_NO_REMOTE': '1', 15:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:26 INFO - 'NO_EM_RESTART': '1', 15:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:26 INFO - 'PWD': '/builds/slave/test', 15:38:26 INFO - 'SHELL': '/bin/bash', 15:38:26 INFO - 'SHLVL': '1', 15:38:26 INFO - 'TERM': 'linux', 15:38:26 INFO - 'TMOUT': '86400', 15:38:26 INFO - 'USER': 'cltbld', 15:38:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:26 INFO - '_': '/tools/buildbot/bin/python'} 15:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:38:26 INFO - Cleaning up... 15:38:26 INFO - Return code: 0 15:38:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:38:26 INFO - Using env: {'DISPLAY': ':0', 15:38:26 INFO - 'HOME': '/home/cltbld', 15:38:26 INFO - 'LANG': 'en_US.UTF-8', 15:38:26 INFO - 'LANGUAGE': 'en_US:en', 15:38:26 INFO - 'LOGNAME': 'cltbld', 15:38:26 INFO - 'MAIL': '/var/mail/cltbld', 15:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:26 INFO - 'MOZ_NO_REMOTE': '1', 15:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:26 INFO - 'NO_EM_RESTART': '1', 15:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:26 INFO - 'PWD': '/builds/slave/test', 15:38:26 INFO - 'SHELL': '/bin/bash', 15:38:26 INFO - 'SHLVL': '1', 15:38:26 INFO - 'TERM': 'linux', 15:38:26 INFO - 'TMOUT': '86400', 15:38:26 INFO - 'USER': 'cltbld', 15:38:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:26 INFO - '_': '/tools/buildbot/bin/python'} 15:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:26 INFO - Downloading/unpacking psutil>=3.1.1 15:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:28 INFO - Installing collected packages: psutil 15:38:28 INFO - Running setup.py install for psutil 15:38:28 INFO - building 'psutil._psutil_linux' extension 15:38:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:38:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:38:28 INFO - building 'psutil._psutil_posix' extension 15:38:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:38:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:38:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:29 INFO - Successfully installed psutil 15:38:29 INFO - Cleaning up... 15:38:29 INFO - Return code: 0 15:38:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:38:29 INFO - Using env: {'DISPLAY': ':0', 15:38:29 INFO - 'HOME': '/home/cltbld', 15:38:29 INFO - 'LANG': 'en_US.UTF-8', 15:38:29 INFO - 'LANGUAGE': 'en_US:en', 15:38:29 INFO - 'LOGNAME': 'cltbld', 15:38:29 INFO - 'MAIL': '/var/mail/cltbld', 15:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:29 INFO - 'MOZ_NO_REMOTE': '1', 15:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:29 INFO - 'NO_EM_RESTART': '1', 15:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:29 INFO - 'PWD': '/builds/slave/test', 15:38:29 INFO - 'SHELL': '/bin/bash', 15:38:29 INFO - 'SHLVL': '1', 15:38:29 INFO - 'TERM': 'linux', 15:38:29 INFO - 'TMOUT': '86400', 15:38:29 INFO - 'USER': 'cltbld', 15:38:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:29 INFO - '_': '/tools/buildbot/bin/python'} 15:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:38:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:38:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:38:31 INFO - Installing collected packages: mozsystemmonitor 15:38:31 INFO - Running setup.py install for mozsystemmonitor 15:38:31 INFO - Successfully installed mozsystemmonitor 15:38:31 INFO - Cleaning up... 15:38:31 INFO - Return code: 0 15:38:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:31 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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:38:31 INFO - Using env: {'DISPLAY': ':0', 15:38:31 INFO - 'HOME': '/home/cltbld', 15:38:31 INFO - 'LANG': 'en_US.UTF-8', 15:38:31 INFO - 'LANGUAGE': 'en_US:en', 15:38:31 INFO - 'LOGNAME': 'cltbld', 15:38:31 INFO - 'MAIL': '/var/mail/cltbld', 15:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:31 INFO - 'MOZ_NO_REMOTE': '1', 15:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:31 INFO - 'NO_EM_RESTART': '1', 15:38:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:31 INFO - 'PWD': '/builds/slave/test', 15:38:31 INFO - 'SHELL': '/bin/bash', 15:38:31 INFO - 'SHLVL': '1', 15:38:31 INFO - 'TERM': 'linux', 15:38:31 INFO - 'TMOUT': '86400', 15:38:31 INFO - 'USER': 'cltbld', 15:38:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:31 INFO - '_': '/tools/buildbot/bin/python'} 15:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:31 INFO - Downloading/unpacking jsonschema==2.5.1 15:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:38:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:33 INFO - Downloading functools32-3.2.3-2.tar.gz 15:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:38:33 INFO - warning: no files found matching '*.txt' 15:38:33 INFO - no previously-included directories found matching 'build' 15:38:33 INFO - no previously-included directories found matching 'dist' 15:38:33 INFO - no previously-included directories found matching '.git*' 15:38:33 INFO - Installing collected packages: jsonschema, functools32 15:38:33 INFO - Running setup.py install for functools32 15:38:34 INFO - warning: no files found matching '*.txt' 15:38:34 INFO - no previously-included directories found matching 'build' 15:38:34 INFO - no previously-included directories found matching 'dist' 15:38:34 INFO - no previously-included directories found matching '.git*' 15:38:34 INFO - Successfully installed jsonschema functools32 15:38:34 INFO - Cleaning up... 15:38:34 INFO - Return code: 0 15:38:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:38:34 INFO - Using env: {'DISPLAY': ':0', 15:38:34 INFO - 'HOME': '/home/cltbld', 15:38:34 INFO - 'LANG': 'en_US.UTF-8', 15:38:34 INFO - 'LANGUAGE': 'en_US:en', 15:38:34 INFO - 'LOGNAME': 'cltbld', 15:38:34 INFO - 'MAIL': '/var/mail/cltbld', 15:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:34 INFO - 'MOZ_NO_REMOTE': '1', 15:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:34 INFO - 'NO_EM_RESTART': '1', 15:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:34 INFO - 'PWD': '/builds/slave/test', 15:38:34 INFO - 'SHELL': '/bin/bash', 15:38:34 INFO - 'SHLVL': '1', 15:38:34 INFO - 'TERM': 'linux', 15:38:34 INFO - 'TMOUT': '86400', 15:38:34 INFO - 'USER': 'cltbld', 15:38:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:34 INFO - '_': '/tools/buildbot/bin/python'} 15:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:38:34 INFO - Cleaning up... 15:38:34 INFO - Return code: 0 15:38:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:38:34 INFO - Using env: {'DISPLAY': ':0', 15:38:34 INFO - 'HOME': '/home/cltbld', 15:38:34 INFO - 'LANG': 'en_US.UTF-8', 15:38:34 INFO - 'LANGUAGE': 'en_US:en', 15:38:34 INFO - 'LOGNAME': 'cltbld', 15:38:34 INFO - 'MAIL': '/var/mail/cltbld', 15:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:34 INFO - 'MOZ_NO_REMOTE': '1', 15:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:34 INFO - 'NO_EM_RESTART': '1', 15:38:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:34 INFO - 'PWD': '/builds/slave/test', 15:38:34 INFO - 'SHELL': '/bin/bash', 15:38:34 INFO - 'SHLVL': '1', 15:38:34 INFO - 'TERM': 'linux', 15:38:34 INFO - 'TMOUT': '86400', 15:38:34 INFO - 'USER': 'cltbld', 15:38:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:34 INFO - '_': '/tools/buildbot/bin/python'} 15:38:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:36 INFO - Downloading blobuploader-1.2.4.tar.gz 15:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:38:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:38:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:37 INFO - Downloading docopt-0.6.1.tar.gz 15:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:38:37 INFO - Installing collected packages: blobuploader, requests, docopt 15:38:37 INFO - Running setup.py install for blobuploader 15:38:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:38:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:38:37 INFO - Running setup.py install for requests 15:38:37 INFO - Running setup.py install for docopt 15:38:37 INFO - Successfully installed blobuploader requests docopt 15:38:37 INFO - Cleaning up... 15:38:37 INFO - Return code: 0 15:38:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:37 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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:38:37 INFO - Using env: {'DISPLAY': ':0', 15:38:37 INFO - 'HOME': '/home/cltbld', 15:38:37 INFO - 'LANG': 'en_US.UTF-8', 15:38:37 INFO - 'LANGUAGE': 'en_US:en', 15:38:37 INFO - 'LOGNAME': 'cltbld', 15:38:37 INFO - 'MAIL': '/var/mail/cltbld', 15:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:37 INFO - 'MOZ_NO_REMOTE': '1', 15:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:37 INFO - 'NO_EM_RESTART': '1', 15:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:37 INFO - 'PWD': '/builds/slave/test', 15:38:37 INFO - 'SHELL': '/bin/bash', 15:38:37 INFO - 'SHLVL': '1', 15:38:37 INFO - 'TERM': 'linux', 15:38:37 INFO - 'TMOUT': '86400', 15:38:37 INFO - 'USER': 'cltbld', 15:38:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:37 INFO - '_': '/tools/buildbot/bin/python'} 15:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:38 INFO - Running setup.py (path:/tmp/pip-VP2Ir0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:38 INFO - Running setup.py (path:/tmp/pip-8asiGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:38 INFO - Running setup.py (path:/tmp/pip-W_di1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:38 INFO - Running setup.py (path:/tmp/pip-oBVar9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:38 INFO - Running setup.py (path:/tmp/pip-PBZ8cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:38 INFO - Running setup.py (path:/tmp/pip-zmBCNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:38 INFO - Running setup.py (path:/tmp/pip-16PQH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:38 INFO - Running setup.py (path:/tmp/pip-nNsygh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:38 INFO - Running setup.py (path:/tmp/pip-1kH95S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:38 INFO - Running setup.py (path:/tmp/pip-dQDAz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:38 INFO - Running setup.py (path:/tmp/pip-ZRY_yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:38 INFO - Running setup.py (path:/tmp/pip-fvXQZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:38 INFO - Running setup.py (path:/tmp/pip-Nfx1vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:39 INFO - Running setup.py (path:/tmp/pip-JVTGJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:39 INFO - Running setup.py (path:/tmp/pip-yjJyod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:39 INFO - Running setup.py (path:/tmp/pip-s5YNYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:39 INFO - Running setup.py (path:/tmp/pip-s6RbwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:38:39 INFO - Running setup.py install for manifestparser 15:38:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:38:39 INFO - Running setup.py install for mozcrash 15:38:39 INFO - Running setup.py install for mozdebug 15:38:39 INFO - Running setup.py install for mozdevice 15:38:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:38:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:38:39 INFO - Running setup.py install for mozfile 15:38:39 INFO - Running setup.py install for mozhttpd 15:38:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:38:39 INFO - Running setup.py install for mozinfo 15:38:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Running setup.py install for mozInstall 15:38:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Running setup.py install for mozleak 15:38:40 INFO - Running setup.py install for mozlog 15:38:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Running setup.py install for moznetwork 15:38:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Running setup.py install for mozprocess 15:38:40 INFO - Running setup.py install for mozprofile 15:38:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Running setup.py install for mozrunner 15:38:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:38:40 INFO - Running setup.py install for mozscreenshot 15:38:40 INFO - Running setup.py install for moztest 15:38:40 INFO - Running setup.py install for mozversion 15:38:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:38:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:38:41 INFO - Cleaning up... 15:38:41 INFO - Return code: 0 15:38:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:41 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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:38:41 INFO - Using env: {'DISPLAY': ':0', 15:38:41 INFO - 'HOME': '/home/cltbld', 15:38:41 INFO - 'LANG': 'en_US.UTF-8', 15:38:41 INFO - 'LANGUAGE': 'en_US:en', 15:38:41 INFO - 'LOGNAME': 'cltbld', 15:38:41 INFO - 'MAIL': '/var/mail/cltbld', 15:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:41 INFO - 'MOZ_NO_REMOTE': '1', 15:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:41 INFO - 'NO_EM_RESTART': '1', 15:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:41 INFO - 'PWD': '/builds/slave/test', 15:38:41 INFO - 'SHELL': '/bin/bash', 15:38:41 INFO - 'SHLVL': '1', 15:38:41 INFO - 'TERM': 'linux', 15:38:41 INFO - 'TMOUT': '86400', 15:38:41 INFO - 'USER': 'cltbld', 15:38:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:41 INFO - '_': '/tools/buildbot/bin/python'} 15:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:41 INFO - Running setup.py (path:/tmp/pip-UKjxtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:41 INFO - Running setup.py (path:/tmp/pip-TY_Y1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:41 INFO - Running setup.py (path:/tmp/pip-95BvPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:41 INFO - Running setup.py (path:/tmp/pip-z2NiWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:41 INFO - Running setup.py (path:/tmp/pip-v6u3wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:41 INFO - Running setup.py (path:/tmp/pip-iBcpoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:41 INFO - Running setup.py (path:/tmp/pip-oHb7ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:41 INFO - Running setup.py (path:/tmp/pip-RjDCO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:41 INFO - Running setup.py (path:/tmp/pip-xcQwZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:41 INFO - Running setup.py (path:/tmp/pip-T3c7K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:42 INFO - Running setup.py (path:/tmp/pip-VHHNtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:42 INFO - Running setup.py (path:/tmp/pip-IBKu7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:42 INFO - Running setup.py (path:/tmp/pip-zNYS42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:42 INFO - Running setup.py (path:/tmp/pip-XQg5v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:42 INFO - Running setup.py (path:/tmp/pip-lfu5d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:42 INFO - Running setup.py (path:/tmp/pip-sWBZHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:42 INFO - Running setup.py (path:/tmp/pip-PDygIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:38:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:44 INFO - Downloading blessings-1.6.tar.gz 15:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:38:44 INFO - Installing collected packages: blessings 15:38:44 INFO - Running setup.py install for blessings 15:38:44 INFO - Successfully installed blessings 15:38:44 INFO - Cleaning up... 15:38:44 INFO - Return code: 0 15:38:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:44 INFO - Reading from file tmpfile_stdout 15:38:44 INFO - Current package versions: 15:38:44 INFO - argparse == 1.2.1 15:38:44 INFO - blessings == 1.6 15:38:44 INFO - blobuploader == 1.2.4 15:38:44 INFO - docopt == 0.6.1 15:38:44 INFO - functools32 == 3.2.3-2 15:38:44 INFO - jsonschema == 2.5.1 15:38:44 INFO - manifestparser == 1.1 15:38:44 INFO - mozInstall == 1.12 15:38:44 INFO - mozcrash == 0.17 15:38:44 INFO - mozdebug == 0.1 15:38:44 INFO - mozdevice == 0.48 15:38:44 INFO - mozfile == 1.2 15:38:44 INFO - mozhttpd == 0.7 15:38:44 INFO - mozinfo == 0.9 15:38:44 INFO - mozleak == 0.1 15:38:44 INFO - mozlog == 3.3 15:38:44 INFO - moznetwork == 0.27 15:38:44 INFO - mozprocess == 0.23 15:38:44 INFO - mozprofile == 0.28 15:38:44 INFO - mozrunner == 6.12 15:38:44 INFO - mozscreenshot == 0.1 15:38:44 INFO - mozsystemmonitor == 0.3 15:38:44 INFO - moztest == 0.7 15:38:44 INFO - mozversion == 1.4 15:38:44 INFO - psutil == 3.1.1 15:38:44 INFO - requests == 1.2.3 15:38:44 INFO - wsgiref == 0.1.2 15:38:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:44 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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:38:44 INFO - Using env: {'DISPLAY': ':0', 15:38:44 INFO - 'HOME': '/home/cltbld', 15:38:44 INFO - 'LANG': 'en_US.UTF-8', 15:38:44 INFO - 'LANGUAGE': 'en_US:en', 15:38:44 INFO - 'LOGNAME': 'cltbld', 15:38:44 INFO - 'MAIL': '/var/mail/cltbld', 15:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:44 INFO - 'MOZ_NO_REMOTE': '1', 15:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:44 INFO - 'NO_EM_RESTART': '1', 15:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:44 INFO - 'PWD': '/builds/slave/test', 15:38:44 INFO - 'SHELL': '/bin/bash', 15:38:44 INFO - 'SHLVL': '1', 15:38:44 INFO - 'TERM': 'linux', 15:38:44 INFO - 'TMOUT': '86400', 15:38:44 INFO - 'USER': 'cltbld', 15:38:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:44 INFO - '_': '/tools/buildbot/bin/python'} 15:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:38:45 INFO - Cleaning up... 15:38:45 INFO - Return code: 0 15:38:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:45 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 0x21a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, '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': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:38:45 INFO - Using env: {'DISPLAY': ':0', 15:38:45 INFO - 'HOME': '/home/cltbld', 15:38:45 INFO - 'LANG': 'en_US.UTF-8', 15:38:45 INFO - 'LANGUAGE': 'en_US:en', 15:38:45 INFO - 'LOGNAME': 'cltbld', 15:38:45 INFO - 'MAIL': '/var/mail/cltbld', 15:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:45 INFO - 'MOZ_NO_REMOTE': '1', 15:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:45 INFO - 'NO_EM_RESTART': '1', 15:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:45 INFO - 'PWD': '/builds/slave/test', 15:38:45 INFO - 'SHELL': '/bin/bash', 15:38:45 INFO - 'SHLVL': '1', 15:38:45 INFO - 'TERM': 'linux', 15:38:45 INFO - 'TMOUT': '86400', 15:38:45 INFO - 'USER': 'cltbld', 15:38:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:45 INFO - '_': '/tools/buildbot/bin/python'} 15:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:38:45 INFO - Cleaning up... 15:38:45 INFO - Return code: 0 15:38:45 INFO - Running post-action listener: _resource_record_post_action 15:38:45 INFO - Running post-action listener: _start_resource_monitoring 15:38:45 INFO - Starting resource monitoring. 15:38:45 INFO - [mozharness: 2016-10-10 22:38:45.410754Z] Finished create-virtualenv step (success) 15:38:45 INFO - [mozharness: 2016-10-10 22:38:45.411249Z] Running install step. 15:38:45 INFO - Running pre-action listener: _resource_record_pre_action 15:38:45 INFO - Running main action method: install 15:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:45 INFO - Reading from file tmpfile_stdout 15:38:45 INFO - Detecting whether we're running mozinstall >=1.0... 15:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:38:45 INFO - Reading from file tmpfile_stdout 15:38:45 INFO - Output received: 15:38:45 INFO - Usage: mozinstall [options] installer 15:38:45 INFO - Options: 15:38:45 INFO - -h, --help show this help message and exit 15:38:45 INFO - -d DEST, --destination=DEST 15:38:45 INFO - Directory to install application into. [default: 15:38:45 INFO - "/builds/slave/test"] 15:38:45 INFO - --app=APP Application being installed. [default: firefox] 15:38:45 INFO - mkdir: /builds/slave/test/build/application 15:38:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:38:59 INFO - Reading from file tmpfile_stdout 15:38:59 INFO - Output received: 15:38:59 INFO - /builds/slave/test/build/application/firefox/firefox 15:38:59 INFO - Running post-action listener: _resource_record_post_action 15:38:59 INFO - [mozharness: 2016-10-10 22:38:59.807767Z] Finished install step (success) 15:38:59 INFO - [mozharness: 2016-10-10 22:38:59.808042Z] Running run-tests step. 15:38:59 INFO - Running pre-action listener: _resource_record_pre_action 15:38:59 INFO - Running main action method: run_tests 15:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:38:59 INFO - Python 2.7.3 15:38:59 INFO - Return code: 0 15:38:59 INFO - grabbing minidump binary from tooltool 15:38: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')]} 15:38:59 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 0x245e570>, '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 0x245f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:38:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:38:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:38:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:38:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:38:59 INFO - Return code: 0 15:38:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:38:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:38:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:38:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:38:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:38:59 INFO - Using env: {'DISPLAY': ':0', 15:38:59 INFO - 'HOME': '/home/cltbld', 15:38:59 INFO - 'LANG': 'en_US.UTF-8', 15:38:59 INFO - 'LANGUAGE': 'en_US:en', 15:38:59 INFO - 'LOGNAME': 'cltbld', 15:38:59 INFO - 'MAIL': '/var/mail/cltbld', 15:38:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:38:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:59 INFO - 'MOZ_NO_REMOTE': '1', 15:38:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:59 INFO - 'NO_EM_RESTART': '1', 15:38:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:59 INFO - 'PWD': '/builds/slave/test', 15:38:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:38:59 INFO - 'SHELL': '/bin/bash', 15:38:59 INFO - 'SHLVL': '1', 15:38:59 INFO - 'TERM': 'linux', 15:38:59 INFO - 'TMOUT': '86400', 15:38:59 INFO - 'USER': 'cltbld', 15:38:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401', 15:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:59 INFO - '_': '/tools/buildbot/bin/python'} 15:38:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:39:00 INFO - mozversion application_buildid: 20161010134924 15:39:00 INFO - mozversion application_changeset: b35318b86b335200340aad6893828b99c187ad84 15:39:00 INFO - mozversion application_display_name: Firefox 15:39:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:39:00 INFO - mozversion application_name: Firefox 15:39:00 INFO - mozversion application_remotingname: firefox 15:39:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:39:00 INFO - mozversion application_vendor: Mozilla 15:39:00 INFO - mozversion application_version: 50.0 15:39:00 INFO - mozversion platform_buildid: 20161010134924 15:39:00 INFO - mozversion platform_changeset: b35318b86b335200340aad6893828b99c187ad84 15:39:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:39:00 INFO - mozversion platform_version: 50.0 15:39:00 INFO - using testdate: 1476139140 15:39:00 INFO - actual date: 1476139140 15:39:00 INFO - starting webserver on 'localhost:58320' 15:39:00 INFO - SUITE-START | Running 2 tests 15:39:00 INFO - TEST-START | dromaeo_css 15:39:00 INFO - operating with platform_type : linux_ 15:39:00 INFO - Initialising browser for dromaeo_css test... 15:39:00 INFO - TEST-INFO | started process 6870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxx6VOM/profile http://localhost:58320/getInfo.html) 15:39:04 INFO - PROCESS | 6870 | __metrics Screen width/height:1600/1200 15:39:04 INFO - PROCESS | 6870 | colorDepth:24 15:39:04 INFO - PROCESS | 6870 | Browser inner width/height: 1024/697 15:39:04 INFO - PROCESS | 6870 | __metrics 15:39:04 ERROR - PROCESS | 6870 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:39:05 INFO - TEST-INFO | 6870: exit 0 15:39:05 INFO - Browser initialized. 15:39:05 INFO - Running cycle 1/1 for dromaeo_css test... 15:39:05 INFO - TEST-INFO | started process 6995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxx6VOM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:17 INFO - PROCESS | 6995 | RSS: Main: 150478848 15:39:17 INFO - PROCESS | 6995 | 15:40:07 INFO - PROCESS | 6995 | 1476139207102 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:42:15 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:58320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58320/tests/dromaeo/cssquery-ext.html) 15:42:16 INFO - PROCESS | 6995 | RSS: Main: 158248960 15:42:16 INFO - PROCESS | 6995 | 15:45:18 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:58320/tests/dromaeo/cssquery-ext.html (next: http://localhost:58320/tests/dromaeo/cssquery-jquery.html) 15:45:19 INFO - PROCESS | 6995 | RSS: Main: 155869184 15:45:19 INFO - PROCESS | 6995 | 15:48:20 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:58320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58320/tests/dromaeo/cssquery-mootools.html) 15:48:21 INFO - PROCESS | 6995 | RSS: Main: 155242496 15:48:21 INFO - PROCESS | 6995 | 15:51:23 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:58320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58320/tests/dromaeo/cssquery-prototype.html) 15:51:23 INFO - PROCESS | 6995 | RSS: Main: 157065216 15:51:23 INFO - PROCESS | 6995 | 15:54:26 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:58320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58320/tests/dromaeo/cssquery-yui.html) 15:54:26 INFO - PROCESS | 6995 | RSS: Main: 157851648 15:54:26 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:58320/tests/dromaeo/cssquery-yui.html (next: http://localhost:58320/tests/dromaeo/cssquery-dojo.html) 15:57:29 INFO - PROCESS | 6995 | RSS: Main: 157827072 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | __start_tp_report 15:57:29 INFO - PROCESS | 6995 | _x_x_mozilla_page_load 15:57:29 INFO - PROCESS | 6995 | _x_x_mozilla_page_load_details 15:57:29 INFO - PROCESS | 6995 | |i|pagename|runs| 15:57:29 INFO - PROCESS | 6995 | |0;dojo.html;3264;3282.179455136215;3283.015095471358;3303.653116422777;3305.8512366943487;5729.3411257705375;5784.1902133701315;5808.390119037504;5820.796272130477;5825.213596164522;5631.465010823976;5751.971240143804;5776.335721392041;5799.594028418012;5808.012637851565;5201.148707703824;5266.894662106755;5292.894142117156;5314.5748340132695;5320.813771517997;5310;5313.309269794921;5319.281896943901;5320.122179840322;5351.117065684158;5069.898602027957;5083.313752643383;5267.973660131714;5269.736513174326;5278.498542638443;5083.18669012958;5149.047426226122;5178.870528236786;5195.896082078375;5282.894342113136;5134;5194.065068287707;5197.740112994373;5210.062188806013;5221.373435187764;5667.263255776764;5714.799982000652;5737.340205876336;5773.653580785124;5783.103618939072;5797.652140871562;5941.168236446901;6027.276726792769;6029.397060293979;6057.212562366908;6017.097435384683;6028.3971602839365;6031.457168854824;6050.6974651267265;6053.515718742534;5602.24369710088;5620.1569764534825;5622.57830662702;5623.8594035149035;5627.958827616904;6021.397860213943;6141.63943600049;6213.751449942042;6218.129461875341;6226.968865155645;6013.278406591237;6040.124181993587;6058.242719660043;6073.271207455134;6076.088586712029;6128.571000030044;6158.876822463526;6170.136180934673;6171.352008039181;6172.629642221481;5815.709214539256;6012.428819262163;6073.210482637317;6098.54260930432;6153.969230153821;6127.111568822585;6168.938310616926;6183.196184495987;6183.288921773964;6210.875782484325;4716.575508204278;4721.126591580569;4730.219513780256;4736.73947932867;4737.147313483537;4064.065264989069;4096.487939007624;4113.115680128727;4161.667066634662;4207.410962465257;5973.283206015219;5983.6708981005595;6012.218411606551;6014.218151640259;6019.307779605401;6184.567080304336;6228.377162283826;6231.4391704746795;6233.625982441068;6251.499880009588;5739.885202295931;5747.3103227612955;5827.621204621686;5835.503982161564;5868.618539794899;5220.295260139908;5244.029854476934;5245.790168393298;5251.501107394792;5259.973700131552;6185.072239164071;6239.688015599202;6318.526110541728;6331.366863313632;6332;6028.638281703024;6116.3272040076445;6138.109974053827;6178.907316390168;6189.566730328834;6378.107065010995;6406.711697973509;6416.326285740117;6421.775237866652;6421.967890160519;5861.7655293787775;6057.242844644419;6061.1514387984835;6069.089636554552;6086.6652334122045;6028.216331876828;6031.909521357095;6062.999605065115;6129.633877547049;6136.342068855342;5989.131575921554;5999.760009599741;6004.519638428827;6004.609700369637;6039.275286965592;5762.884742305214;5937.970310148422;5984.850378740566;5988.161657368059;5989.7304621293015;5801.6519008859605;5860.706964651665;5890.52875769946;5966.582339236385;6005.759769609342;5957.106434034929;5978.222831032112;6004.699765011645;6029.638221706711;6034.818955431344;5678.063119585222;5861.706914654335;5870;5874.353821079592;5879.470847623735 15:57:29 INFO - PROCESS | 6995 | |1;ext.html;589.5431040943271;649.6167261315824;658.7760161545074;666.273761599856;669.9631520266383;35144;45337.1865125395;45994.770026149905;46113.53886461134;46491.302630460574;49990.25014624783;50848.49151508484;50916.23625645609;50916.236256456184;50957;9363.719088427359;9527.190188833958;9529.094736000068;9531.428114313128;9535.713928582154;9319.813603727922;9379.343445958752;9394.62421503139;9406.811863762721;9420.199283060949;9449.858252126223;9500.572474238641;9519.80960380792;9528.190103841147;9547.904520954771;9438.197753190987;9451.952740236324;9478.90521094787;9492.52537373132;9495.66765163223;9202.30982676302;9309.767255818591;9330.486823224719;9353.76615584609;9375.437473751597;46545.76727116343;47230.52769472296;47384.28923566149;47416.05167896657;47449.76275118637;3926.6073392660505;3956.3867600521967;4054.371572406252;4387.16643837673;4743.928841067387;35529;35635.82182089073;35758.82120589406;35961.28071481757;36116.819415902755;4783.736894470802;4857.53853383928;4908.337374454474;4994.82518111868;5060.165072762989;394472;397262;399261;400264;400542;69341.3065869345;69575.65212174007;69666.30333696598;69674.30325696779;69881.3011869885;40634.18731625351;41739;41862;44053.77973110178;73218;19553;19991.700124498144;19992;20000.59998800045;20007.59984800296;15060.32228549718;15243.466478673194;15280.15959122259;15313.23433828304;15385;21163.25928592492;21324.78675213259;21451.46371340729;21628.675569866464;21678.590891591997;7714.5756983366455;7821.960890195513;7834.764957051298;7868.567228802471;7946.205379462123;1053.942033188182;1074.8602681651334;1094.0645747885603;1129.8700649425257;1153.8903804138592;34843.30313393718;34906.47640285398;35061.29877402438;35150.29699406049;35528.64471355253;1192.5527927027365;1196.3121205306984;1201.3357021642996;1232.734961983178;1345.589595173462;17739.46781596554;18328.175232114587;18541.536461588566;18542;18635.627287454445;647604;649422;651151;651647;652857;66339.33660663429;67132.32867671359;67170.66414667896;67483.32516674869;67665.3233467659;1446.9493567725078;1453.7310597539702;1466.0397439677029;1486.0934829753842;1486.9107853528824;34537.309253815285;34609.48085778665;34656.306873861875;34871.65128348785;35128.648713512535;58817.70591147017;58966.41033589609;59264.40735592589;59387.406125938185;59388;487329;492183;492473;493587;494746;32570.83714581412;32899.177520562174;32903.506447402826;33230.16924576905;33394.33211335711;55117;55124.448755513535;55465.722671386386;56117.43882561122;57203.42796571981;44979;47917.76041119772;48165;48532.64911869049;48541.75729121332;47063.294050588585;47194.52805471901;47552.762236189985;47701.76149119232;48031.75984120057;47079.52920470889;50077.74961125171;50198.49801501938;51811;52150.478495214564;45047.32429013502;48170.759146204044;48547.5145248543;48584.271235932196;49202.50797491979;36533.33999550346;37351;37512.43731344087;37557.2488550222;38025.429618555194 15:57:29 INFO - PROCESS | 6995 | |2;jquery.html;404.6378491250333;411.9711620186588;416.16351134220207;426.15408414297616;427.3290933234821;18963.52591185221;19881.3041543546;20773.27293544726;20955.37133885982;21099.36701898942;19990;20356.287529936457;20465.18139274427;20978.265760698378;21047.158113675436;5881.823545293648;6050.455459008688;6101.267847858263;6104.053871649901;6105.32841387447;5950.583459157839;5954.523638108941;5975.462208401243;5983.192269043667;6030.758769649209;5836.620619659709;5941.376155503674;5993.370696076914;5998.580099393044;6014.939850601481;5982.312034116088;6006.309274433431;6006.609570377933;6044.8186554403;6051.757929682807;5257.579393648499;5396.622236443451;5420.186971954199;5425.6202065855405;5433.918491222635;24034;24829.87585062081;24910.875445622838;25015.87492062546;25310.746892531024;2634.6179803928517;2729.372244383783;2807.7051909549614;2901.7243361880587;3109.782315237934;15439.61400964985;15510.844891551053;15543.378264869392;15631.06213627186;15669.52991410248;1912.3593596145308;1973.8716983396034;1989.4926793667667;2006.6488364536149;2096.3186964236534;83707.16292837054;84485.57757211236;84977.57511212466;86717.56641216816;87246.56376718076;10278.486075696186;10447.895521044844;10581.41802200871;11392.20254582188;11556.653300401002;15561.377544898078;15829.920850395905;15859;16123.83876161247;16139.273732682057;9169.22061624756;9236.491992940319;9294.163525282756;9364.20404265645;9415.340926135104;9316.487593182304;9321.860172097424;9327.207187389147;9486.430814151174;9552.331336806496;6850.6574671266235;6946.930530694628;7084.326988936043;7128.073350464407;7136.857262854714;1999.9200031998557;2040.4388793081725;2055.9177632894516;2075.7612874519623;2103.8527303088945;951.2532661860545;1058.1746237934424;1064.9148068154684;1067.6156583629886;1117;20738;21149;21373.572528549652;21506.89246553757;21691.240806571695;1061.570064124031;1068.8610480637624;1073.7906108308962;1117.3966058328413;1181.497863408048;11324.94337528307;11761.588344407905;11970.82043769344;12010;12056.698582535331;539114;540912;567687;579489;580354;55754.72122639361;57083.14375284374;88176;91112.54443727739;101421;1049.2445439283704;1070.9036186743074;1096.4517741129434;1098.5056724474018;1106.734383747911;16392.508224753277;16785.748213777046;18311.908440458246;18559.35042273514;19014.700079419123;41996.37005444982;42130.36804447997;43758.12483750371;44236.55763442325;45088.09823803571;57492.712536438725;58120;62262;62946;64285.03572446323;9216.815663686555;9406.05939406054;9411.10594493522;9415.57629906642;9489.905100948901;13728.794068089186;13832.446702131801;13998.650033749238;14006.579802605938;14206.218657973497;12511.186772859735;12606.432710528232;12651.367431628565;12760.170588911691;12861.155598129944;11602.94198529002;12186.57346992851;12262.938685306517;12279.938600306941;12943.611691649265;12101.273923564615;12566.811497827723;12588.30764307972;12706.237625742486;12925.095243332877;8688.39181257306;8938.776530586787;9010.14403631654;9027.45835249887;9514.23886089125;5345.759440825094;9217.308701847254;11408.657740267805;11446.37044962535;12682.682932926382 15:57:29 INFO - PROCESS | 6995 | |3;mootools.html;1566.5691934717952;1569.18402430736;1769.4337811900198;1792.533941175294;1876.1651065275958;8118.147594502573;8656.653733850655;8791.384603077779;8831.47011179329;9147.542622868863;9103.817923641524;9250.213731832802;9258.25933925286;9278.58246378913;9330.253579713624;2483.3295010347197;2508.849469031855;2510.134003768697;2512.5854234051358;2523.73500782418;2451.901923923041;2480.851148931061;2497.12600589793;2504.4991001799713;2505.949881002388;2457.2430712040887;2477.4054226985486;2478.529079474903;2488.415222422729;2493.463905260369;2376;2403.7476065013097;2405.747396523375;2409.3976505873534;2412.9276121716375;2346.296111166643;2369.419492224416;2369.5024044950583;2409.578323793329;2416.5287768885073;9022.052684468103;9127.497987610679;9149.085091490864;9153.221976132038;9170.082991700843;5316.707581083039;5456.208849716809;5468.64453810505;5473.124300112003;5475.808346707846;3422.2625763078627;3460.740444466675;3490.493878387645;3514.437689969618;3568.07230120168;1281.609109221687;1312.3372696788156;1325.7481078595035;1339.8794108530278;1372.1492674541748;12415.62753117408;12543.686407839878;12548.24710517372;12564.685882852911;12565.434555444936;4635.536446355405;4685.81256749733;4755.072760811678;4758.738269395148;4789.928151077667;9975;10004.449755263531;10017.04838040385;10033.14718248957;10045.397276163454;5459.863503412446;5474.972625136849;5477.452254774491;5492.47821456961;5493.670379777146;4443.089166720814;4992.226204938241;5119.488051194925;5161.974190129101;5170.97414512925;3896.7661940283674;3924.175923056133;3938.113924367052;4018.6985976051915;4032.1330913853662;1133.438947720867;1141.577616281981;1156.9595064172713;1157.7684463107244;1159.47244003978;948.672707915768;983.2379905573238;984.5471083301618;996.7657600463886;1002.9598816047422;5763.3084029915835;6150.50795936333;6367.777127800505;6462.741490340428;6482.416582507597;481.37421352241944;491.41030763084444;495.6679025053223;510.6093838213769;511.20507610665027;4317.158154159972;4415.823367065282;4422.845200418034;4433.512313645497;4561.657875659273;10782.622608208674;11251.718707032389;11293.54825806975;11296.096312294996;11304.604338848265;10815.67552973412;10882;11047;11163.497642606102;11189.776204475866;8351.24838764514;8355.456895301786;8373.455725377831;8374.748757537283;8378.539180345018;6099.115628233792;6103.633781973096;6199.845003874759;6209.534284928739;6343.746250149942;9937.801243975224;10000.59997600117;10135;10329.845052324372;10461.372317660966;10527.420991845522;10607.681769546925;10658.467076646291;10670.786584268117;10720;8302;8578.313734901069;8588.914110858812;8689.522076285864;8877.955610221907;8918;8945.955270223867;8991.325650576364;9007;9028.59371328305;7739.032620922385;7797.103333116765;7819.569923654026;7956.164602716863;8326.29226515753;7618.96190519066;7688.384929205762;7703.730369437043;7710.26752458538;7916.366690664848;7400.777976660709;7438.73964411243;7491.662875170739;7500.362469189961;7530.849383012419;5378.381486128988;5426.186072089218;5483.588730845123;5504.724763761876;5552.611317207757;5239.921401179062;5292.0738870696705;5304.814331498379;5350.090484617546;5367.704776237344 15:57:29 INFO - PROCESS | 6995 | |4;prototype.html;349.51417529633807;351.79771631311985;353.69228770969255;358.4605169220323;362.526902392378;5774.238857148568;5785.3925337839555;5807.274090738658;5827.184194212814;5844.941550584493;5669.829905102843;5699.202111704354;5730.598858079936;5744.770209191627;5758.596898217126;4173.728707634002;4407.933880991788;4416.536263692315;4419.955800442002;4494.775261236925;4457.687961842672;4470.463544374679;4493.168763778712;4502.57225563571;4512.85639321323;4276.850310239142;4421.491528474218;4424.867253982369;4476.187144206601;4491.30384790358;4395.7362558246605;4413.271810151321;4414.293713005935;4422.137683151771;4434.8669539913535;3868.729188956774;3873.98063009686;3878.9635441393493;3894.7663140211394;3900.3369427197445;5502.9174562381595;5556.277683901067;5592.217089607459;5607.5607110906885;5640.8307750767135;5043.924341134886;5083.847484575469;5087.872803179913;5091.46539613339;5098.209777484496;5866.941330586682;5928.02187639039;5982.4316689914385;5986.132010858445;5989.610675306135;4217.240896638604;4300.742110392038;4309.59058889405;4342.565743425664;4368.956310436887;6213.130161777355;6226.1905952225925;6276.152719382871;6307.936920630781;6333.176687030703;4464.218761716752;4465.553444655508;4466.062126953311;4471.754053527022;4472.843450479218;4263.317869140985;4480.417545719036;4493.842955381435;4523.36672865799;4543.795529201194;5081.441041485434;5081.59347252219;5102.515261050195;5109;5126.7180305083575;6035.275766907999;6039.829089727928;6061.605995610271;6087.452129308295;6119.449249567471;1473.6463248820205;1527.152430401138;1537.9077255364714;1554.8134223893205;1555.7510798272222;962.2782912815388;974.1670871404989;983.8622592837008;990.9693918324862;993.8161440133598;5201.479852014844;5208.229202071238;5219.817306394258;5225.033368826779;5245.793467502496;5422.7017514036315;5441.727913604304;5442.374126975448;5446.945530544644;5487.972560137254;5240.737963101829;5723.283015095455;6002.369751176151;6010.188624535719;6013;3308.652591477908;3338.7662863599317;3344.5317655528247;3346.728243267543;3353.815540145267;6261.749530018839;6417.74329026843;6461.870762584722;6526.28210896801;6547.333493243798;6366.363363663597;6375.71309291083;6377.7448902044325;6389.744410223539;6427.903581446282;6329.082283068929;6445.035283769518;6511.316311787289;6560.770373037016;6577.144971153815;6184.628922264678;6186.597871138361;6227.16298691896;6247.250329960434;6257.530685198537;6146.53900957439;6173.6913154343;6180.845478863064;6182.567220294716;6209.658468784261;6207.441330280297;6404.327545607644;6454.451371633464;6454.774082907075;6456.225252969673;4368.475782906072;4401.4278143842375;4403.053343531028;4416.094700586436;4423.977880110579;5997.580169388101;6171.444569988723;6232.844178895564;6239.847252697812;6275;6000.759969601167;6031.215941927697;6062.999210260516;6100.261425493713;6116.908246376397;6040.275166979991;6042.063480160582;6050.878982420415;6058.061420345447;6092.268927728701;5801.941980580309;5963.389884731185;5968.850778730392;5980.312264089512;6008.759649613967;6007.339192688888;6052.697365131814;6060.696965151813;6093.542984276109;6126.5711400203345;5780.161876527795;5876.500497457593;5917.437843404869;5971.28344598651;5981.641101533748 15:57:29 INFO - PROCESS | 6995 | |5;yui.html;782.0927723840344;785.112822510563;800.8158123631565;877.7410663854166;915.0529202275646;15800.44698435555;16388.098654573994;16850.915745421287;16855.83144168558;17838.910805445987;15421.614459638515;15596;15666;15711.764323535128;15766.054036757774;868.7133246028811;873.3362644390246;888.4447220487195;889.8220355928808;904.2585080234211;903.7966457547066;903.9276857851389;905.1853332001185;911.1617312072909;911.2436677557645;954.5179684259439;954.5322791831987;954.9952250238739;955.8852937647492;958.0850287975002;945.6122989574276;949.7625593601599;951.7620594851287;954.7708549947962;955.44106697582;700.250731717063;702.2661318921688;702.9086218791575;703.7290643102391;703.7747920665389;15444.305006274744;15455.072695638297;15503.379864805394;15509.146996915166;15510.767338489932;15306.311215995307;15364.769528457082;15620.531384058497;15731.606709832231;16279.023258604404;14556.927215363961;14755.631109222248;14769.92615036918;14772.187529685863;15046.849531504655;4841.685290456145;4881.780319885614;4888.0957022950515;4966;5140.177571588528;91712;92308.53845730795;92395.53802231012;92566.53716731441;93866.5306673469;12639.747205056032;12696.555620553236;12710.110292279636;12715.173513721578;12783.424745886457;21258.043388047576;22931.42671433194;22932.426689332566;22937.770622293898;22945.426364341027;9505.762355941157;9594.952025239969;9639.951800240953;9642.807143857084;9715.61137554504;5110.156824124052;5136.691798492103;5221.986787984544;5311.468853114658;5387.973060134675;3920;4010.137820368635;4023.517177938666;4034.23349563582;4040.575739547305;665.7270519087151;671.9932800672028;672.1463741048841;677.2854638356581;680.897865320196;744.817519707675;788.2157253532772;800.5756948817136;826.7726375246855;878.5168157513342;10708.94645526783;10709.946450267698;10796.460176991119;10815.729606759895;11670.440515642811;675.6621689155422;679.7111227728195;686.2931180883697;740.5556666000357;826.5371392020488;4833.419989601271;5069.797208111708;5143.408508021551;5233.319668443154;5249.658772179796;65943.67028164829;66581.33418665848;69729;70051.64974175199;70146;105305;105456;105798.471007646;106346.46826765971;107294;93225.53387233157;93636;95693.52153239328;95998.56271646594;97731;9753.707388778348;10153.39079655223;10192.694219173436;10201.38791672502;10237.48812559384;52141;52612.47387526076;52899.471005290994;53063;56479.71760141173;50143.74928125336;52780.73609631927;68961.3103868955;74517;74777.62611186909;13216.074874759059;13710.65723356924;13735.725285494034;13971.510997115052;14693.853061469676;16228.756568651715;16308.510744677678;16348.918255408647;16732;17370.652586948443;14145.717085658434;14169;14434.639134021734;15396;15479.148646824533;14454;14653.560393188221;14796.704065918406;14942.103473791607;14950.700985980437;14690.485832995793;14712.852871471148;15272.389104435699;15313.693726125191;16190.919045404698;11365.782727967635;11546.884531154918;11595.536178552764;11684;12042.337671427806;10894.61868834587;11607.941960290145;11698.94150529242;11911.583094591648;13125.081244312807 15:57:29 INFO - PROCESS | 6995 | __end_tp_report 15:57:29 INFO - PROCESS | 6995 | __start_cc_report 15:57:29 INFO - PROCESS | 6995 | _x_x_mozilla_cycle_collect,329 15:57:29 INFO - PROCESS | 6995 | __end_cc_report 15:57:29 INFO - PROCESS | 6995 | __startTimestamp1476140249453__endTimestamp 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | ------- Summary: start ------- 15:57:29 INFO - PROCESS | 6995 | Number of tests: 6 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | [#0] dojo.html Cycles:165 Average:5687.27 Median:5937.97 stddev:645.87 (10.9%) stddev-sans-first:619.24 15:57:29 INFO - PROCESS | 6995 | Values: 3264.0 3282.2 3283.0 3303.7 3305.9 5729.3 5784.2 5808.4 5820.8 5825.2 5631.5 5752.0 5776.3 5799.6 5808.0 5201.1 5266.9 5292.9 5314.6 5320.8 5310.0 5313.3 5319.3 5320.1 5351.1 5069.9 5083.3 5268.0 5269.7 5278.5 5083.2 5149.0 5178.9 5195.9 5282.9 5134.0 5194.1 5197.7 5210.1 5221.4 5667.3 5714.8 5737.3 5773.7 5783.1 5797.7 5941.2 6027.3 6029.4 6057.2 6017.1 6028.4 6031.5 6050.7 6053.5 5602.2 5620.2 5622.6 5623.9 5628.0 6021.4 6141.6 6213.8 6218.1 6227.0 6013.3 6040.1 6058.2 6073.3 6076.1 6128.6 6158.9 6170.1 6171.4 6172.6 5815.7 6012.4 6073.2 6098.5 6154.0 6127.1 6168.9 6183.2 6183.3 6210.9 4716.6 4721.1 4730.2 4736.7 4737.1 4064.1 4096.5 4113.1 4161.7 4207.4 5973.3 5983.7 6012.2 6014.2 6019.3 6184.6 6228.4 6231.4 6233.6 6251.5 5739.9 5747.3 5827.6 5835.5 5868.6 5220.3 5244.0 5245.8 5251.5 5260.0 6185.1 6239.7 6318.5 6331.4 6332.0 6028.6 6116.3 6138.1 6178.9 6189.6 6378.1 6406.7 6416.3 6421.8 6422.0 5861.8 6057.2 6061.2 6069.1 6086.7 6028.2 6031.9 6063.0 6129.6 6136.3 5989.1 5999.8 6004.5 6004.6 6039.3 5762.9 5938.0 5984.9 5988.2 5989.7 5801.7 5860.7 5890.5 5966.6 6005.8 5957.1 5978.2 6004.7 6029.6 6034.8 5678.1 5861.7 5870.0 5874.4 5879.5 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | [#1] ext.html Cycles:180 Average:69324.99 Median:26242.75 stddev:139208.04 (530.5%) stddev-sans-first:139502.89 15:57:29 INFO - PROCESS | 6995 | Values: 589.5 649.6 658.8 666.3 670.0 35144.0 45337.2 45994.8 46113.5 46491.3 49990.3 50848.5 50916.2 50916.2 50957.0 9363.7 9527.2 9529.1 9531.4 9535.7 9319.8 9379.3 9394.6 9406.8 9420.2 9449.9 9500.6 9519.8 9528.2 9547.9 9438.2 9452.0 9478.9 9492.5 9495.7 9202.3 9309.8 9330.5 9353.8 9375.4 46545.8 47230.5 47384.3 47416.1 47449.8 3926.6 3956.4 4054.4 4387.2 4743.9 35529.0 35635.8 35758.8 35961.3 36116.8 4783.7 4857.5 4908.3 4994.8 5060.2 394472.0 397262.0 399261.0 400264.0 400542.0 69341.3 69575.7 69666.3 69674.3 69881.3 40634.2 41739.0 41862.0 44053.8 73218.0 19553.0 19991.7 19992.0 20000.6 20007.6 15060.3 15243.5 15280.2 15313.2 15385.0 21163.3 21324.8 21451.5 21628.7 21678.6 7714.6 7822.0 7834.8 7868.6 7946.2 1053.9 1074.9 1094.1 1129.9 1153.9 34843.3 34906.5 35061.3 35150.3 35528.6 1192.6 1196.3 1201.3 1232.7 1345.6 17739.5 18328.2 18541.5 18542.0 18635.6 647604.0 649422.0 651151.0 651647.0 652857.0 66339.3 67132.3 67170.7 67483.3 67665.3 1446.9 1453.7 1466.0 1486.1 1486.9 34537.3 34609.5 34656.3 34871.7 35128.6 58817.7 58966.4 59264.4 59387.4 59388.0 487329.0 492183.0 492473.0 493587.0 494746.0 32570.8 32899.2 32903.5 33230.2 33394.3 55117.0 55124.4 55465.7 56117.4 57203.4 44979.0 47917.8 48165.0 48532.6 48541.8 47063.3 47194.5 47552.8 47701.8 48031.8 47079.5 50077.7 50198.5 51811.0 52150.5 45047.3 48170.8 48547.5 48584.3 49202.5 36533.3 37351.0 37512.4 37557.2 38025.4 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | [#2] jquery.html Cycles:180 Average:31517.82 Median:24963.38 stddev:92098.99 (368.9%) stddev-sans-first:92327.73 15:57:29 INFO - PROCESS | 6995 | Values: 404.6 412.0 416.2 426.2 427.3 18963.5 19881.3 20773.3 20955.4 21099.4 19990.0 20356.3 20465.2 20978.3 21047.2 5881.8 6050.5 6101.3 6104.1 6105.3 5950.6 5954.5 5975.5 5983.2 6030.8 5836.6 5941.4 5993.4 5998.6 6014.9 5982.3 6006.3 6006.6 6044.8 6051.8 5257.6 5396.6 5420.2 5425.6 5433.9 24034.0 24829.9 24910.9 25015.9 25310.7 2634.6 2729.4 2807.7 2901.7 3109.8 15439.6 15510.8 15543.4 15631.1 15669.5 1912.4 1973.9 1989.5 2006.6 2096.3 83707.2 84485.6 84977.6 86717.6 87246.6 10278.5 10447.9 10581.4 11392.2 11556.7 15561.4 15829.9 15859.0 16123.8 16139.3 9169.2 9236.5 9294.2 9364.2 9415.3 9316.5 9321.9 9327.2 9486.4 9552.3 6850.7 6946.9 7084.3 7128.1 7136.9 1999.9 2040.4 2055.9 2075.8 2103.9 951.3 1058.2 1064.9 1067.6 1117.0 20738.0 21149.0 21373.6 21506.9 21691.2 1061.6 1068.9 1073.8 1117.4 1181.5 11324.9 11761.6 11970.8 12010.0 12056.7 539114.0 540912.0 567687.0 579489.0 580354.0 55754.7 57083.1 88176.0 91112.5 101421.0 1049.2 1070.9 1096.5 1098.5 1106.7 16392.5 16785.7 18311.9 18559.4 19014.7 41996.4 42130.4 43758.1 44236.6 45088.1 57492.7 58120.0 62262.0 62946.0 64285.0 9216.8 9406.1 9411.1 9415.6 9489.9 13728.8 13832.4 13998.7 14006.6 14206.2 12511.2 12606.4 12651.4 12760.2 12861.2 11602.9 12186.6 12262.9 12279.9 12943.6 12101.3 12566.8 12588.3 12706.2 12925.1 8688.4 8938.8 9010.1 9027.5 9514.2 5345.8 9217.3 11408.7 11446.4 12682.7 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | [#3] mootools.html Cycles:180 Average:5982.40 Median:486.39 stddev:3372.43 (693.4%) stddev-sans-first:3365.56 15:57:29 INFO - PROCESS | 6995 | Values: 1566.6 1569.2 1769.4 1792.5 1876.2 8118.1 8656.7 8791.4 8831.5 9147.5 9103.8 9250.2 9258.3 9278.6 9330.3 2483.3 2508.8 2510.1 2512.6 2523.7 2451.9 2480.9 2497.1 2504.5 2505.9 2457.2 2477.4 2478.5 2488.4 2493.5 2376.0 2403.7 2405.7 2409.4 2412.9 2346.3 2369.4 2369.5 2409.6 2416.5 9022.1 9127.5 9149.1 9153.2 9170.1 5316.7 5456.2 5468.6 5473.1 5475.8 3422.3 3460.7 3490.5 3514.4 3568.1 1281.6 1312.3 1325.7 1339.9 1372.1 12415.6 12543.7 12548.2 12564.7 12565.4 4635.5 4685.8 4755.1 4758.7 4789.9 9975.0 10004.4 10017.0 10033.1 10045.4 5459.9 5475.0 5477.5 5492.5 5493.7 4443.1 4992.2 5119.5 5162.0 5171.0 3896.8 3924.2 3938.1 4018.7 4032.1 1133.4 1141.6 1157.0 1157.8 1159.5 948.7 983.2 984.5 996.8 1003.0 5763.3 6150.5 6367.8 6462.7 6482.4 481.4 491.4 495.7 510.6 511.2 4317.2 4415.8 4422.8 4433.5 4561.7 10782.6 11251.7 11293.5 11296.1 11304.6 10815.7 10882.0 11047.0 11163.5 11189.8 8351.2 8355.5 8373.5 8374.7 8378.5 6099.1 6103.6 6199.8 6209.5 6343.7 9937.8 10000.6 10135.0 10329.8 10461.4 10527.4 10607.7 10658.5 10670.8 10720.0 8302.0 8578.3 8588.9 8689.5 8878.0 8918.0 8946.0 8991.3 9007.0 9028.6 7739.0 7797.1 7819.6 7956.2 8326.3 7619.0 7688.4 7703.7 7710.3 7916.4 7400.8 7438.7 7491.7 7500.4 7530.8 5378.4 5426.2 5483.6 5504.7 5552.6 5239.9 5292.1 5304.8 5350.1 5367.7 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | [#4] prototype.html Cycles:180 Average:5050.24 Median:5751.68 stddev:1496.88 (26.0%) stddev-sans-first:1458.90 15:57:29 INFO - PROCESS | 6995 | Values: 349.5 351.8 353.7 358.5 362.5 5774.2 5785.4 5807.3 5827.2 5844.9 5669.8 5699.2 5730.6 5744.8 5758.6 4173.7 4407.9 4416.5 4420.0 4494.8 4457.7 4470.5 4493.2 4502.6 4512.9 4276.9 4421.5 4424.9 4476.2 4491.3 4395.7 4413.3 4414.3 4422.1 4434.9 3868.7 3874.0 3879.0 3894.8 3900.3 5502.9 5556.3 5592.2 5607.6 5640.8 5043.9 5083.8 5087.9 5091.5 5098.2 5866.9 5928.0 5982.4 5986.1 5989.6 4217.2 4300.7 4309.6 4342.6 4369.0 6213.1 6226.2 6276.2 6307.9 6333.2 4464.2 4465.6 4466.1 4471.8 4472.8 4263.3 4480.4 4493.8 4523.4 4543.8 5081.4 5081.6 5102.5 5109.0 5126.7 6035.3 6039.8 6061.6 6087.5 6119.4 1473.6 1527.2 1537.9 1554.8 1555.8 962.3 974.2 983.9 991.0 993.8 5201.5 5208.2 5219.8 5225.0 5245.8 5422.7 5441.7 5442.4 5446.9 5488.0 5240.7 5723.3 6002.4 6010.2 6013.0 3308.7 3338.8 3344.5 3346.7 3353.8 6261.7 6417.7 6461.9 6526.3 6547.3 6366.4 6375.7 6377.7 6389.7 6427.9 6329.1 6445.0 6511.3 6560.8 6577.1 6184.6 6186.6 6227.2 6247.3 6257.5 6146.5 6173.7 6180.8 6182.6 6209.7 6207.4 6404.3 6454.5 6454.8 6456.2 4368.5 4401.4 4403.1 4416.1 4424.0 5997.6 6171.4 6232.8 6239.8 6275.0 6000.8 6031.2 6063.0 6100.3 6116.9 6040.3 6042.1 6050.9 6058.1 6092.3 5801.9 5963.4 5968.9 5980.3 6008.8 6007.3 6052.7 6060.7 6093.5 6126.6 5780.2 5876.5 5917.4 5971.3 5981.6 15:57:29 INFO - PROCESS | 6995 | 15:57:29 INFO - PROCESS | 6995 | [#5] yui.html Cycles:180 Average:20825.52 Median:4861.73 stddev:28362.79 (583.4%) stddev-sans-first:28402.43 15:57:29 INFO - PROCESS | 6995 | Values: 782.1 785.1 800.8 877.7 915.1 15800.4 16388.1 16850.9 16855.8 17838.9 15421.6 15596.0 15666.0 15711.8 15766.1 868.7 873.3 888.4 889.8 904.3 903.8 903.9 905.2 911.2 911.2 954.5 954.5 955.0 955.9 958.1 945.6 949.8 951.8 954.8 955.4 700.3 702.3 702.9 703.7 703.8 15444.3 15455.1 15503.4 15509.1 15510.8 15306.3 15364.8 15620.5 15731.6 16279.0 14556.9 14755.6 14769.9 14772.2 15046.8 4841.7 4881.8 4888.1 4966.0 5140.2 91712.0 92308.5 92395.5 92566.5 93866.5 12639.7 12696.6 12710.1 12715.2 12783.4 21258.0 22931.4 22932.4 22937.8 22945.4 9505.8 9595.0 9640.0 9642.8 9715.6 5110.2 5136.7 5222.0 5311.5 5388.0 3920.0 4010.1 4023.5 4034.2 4040.6 665.7 672.0 672.1 677.3 680.9 744.8 788.2 800.6 826.8 878.5 10708.9 10709.9 10796.5 10815.7 11670.4 675.7 679.7 686.3 740.6 826.5 4833.4 5069.8 5143.4 5233.3 5249.7 65943.7 66581.3 69729.0 70051.6 70146.0 105305.0 105456.0 105798.5 106346.5 107294.0 93225.5 93636.0 95693.5 95998.6 97731.0 9753.7 10153.4 10192.7 10201.4 10237.5 52141.0 52612.5 52899.5 53063.0 56479.7 50143.7 52780.7 68961.3 74517.0 74777.6 13216.1 13710.7 13735.7 13971.5 14693.9 16228.8 16308.5 16348.9 16732.0 17370.7 14145.7 14169.0 14434.6 15396.0 15479.1 14454.0 14653.6 14796.7 14942.1 14950.7 14690.5 14712.9 15272.4 15313.7 16190.9 11365.8 11546.9 11595.5 11684.0 12042.3 10894.6 11607.9 11698.9 11911.6 13125.1 15:57:29 INFO - PROCESS | 6995 | -------- Summary: end -------- 15:57:29 INFO - PROCESS | 6995 | 15:57:30 INFO - TEST-INFO | 6995: exit 0 15:57:30 INFO - TEST-OK | dromaeo_css | took 1110088ms 15:57:30 INFO - TEST-START | kraken 15:57:30 INFO - operating with platform_type : linux_ 15:57:30 INFO - Initialising browser for kraken test... 15:57:30 INFO - TEST-INFO | started process 7233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplc8Gma/profile http://localhost:58320/getInfo.html) 15:57:34 INFO - PROCESS | 7233 | __metrics Screen width/height:1600/1200 15:57:34 INFO - PROCESS | 7233 | colorDepth:24 15:57:34 INFO - PROCESS | 7233 | Browser inner width/height: 1024/697 15:57:34 INFO - PROCESS | 7233 | __metrics 15:57:34 ERROR - PROCESS | 7233 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:57:35 INFO - TEST-INFO | 7233: exit 0 15:57:35 INFO - Browser initialized. 15:57:35 INFO - Running cycle 1/1 for kraken test... 15:57:35 INFO - TEST-INFO | started process 7356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplc8Gma/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:47 INFO - PROCESS | 7356 | RSS: Main: 150511616 15:57:47 INFO - PROCESS | 7356 | 15:57:49 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58320/tests/kraken/driver.html?testName=audio-beat-detection) 15:57:50 INFO - PROCESS | 7356 | RSS: Main: 157138944 15:57:50 INFO - PROCESS | 7356 | 15:57:53 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58320/tests/kraken/driver.html?testName=audio-dft) 15:57:53 INFO - PROCESS | 7356 | RSS: Main: 155979776 15:57:53 INFO - PROCESS | 7356 | 15:57:56 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58320/tests/kraken/driver.html?testName=audio-fft) 15:57:57 INFO - PROCESS | 7356 | RSS: Main: 156606464 15:57:57 INFO - PROCESS | 7356 | 15:57:59 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58320/tests/kraken/driver.html?testName=audio-oscillator) 15:57:59 INFO - PROCESS | 7356 | RSS: Main: 156270592 15:57:59 INFO - PROCESS | 7356 | 15:58:02 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:58:02 INFO - PROCESS | 7356 | RSS: Main: 155865088 15:58:02 INFO - PROCESS | 7356 | 15:58:05 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58320/tests/kraken/driver.html?testName=imaging-darkroom) 15:58:06 INFO - PROCESS | 7356 | RSS: Main: 156016640 15:58:06 INFO - PROCESS | 7356 | 15:58:09 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58320/tests/kraken/driver.html?testName=imaging-desaturate) 15:58:10 INFO - PROCESS | 7356 | RSS: Main: 156491776 15:58:10 INFO - PROCESS | 7356 | 15:58:13 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58320/tests/kraken/driver.html?testName=json-parse-financial) 15:58:13 INFO - PROCESS | 7356 | RSS: Main: 156741632 15:58:13 INFO - PROCESS | 7356 | 15:58:15 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:58:15 INFO - PROCESS | 7356 | RSS: Main: 156155904 15:58:15 INFO - PROCESS | 7356 | 15:58:17 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:58:18 INFO - PROCESS | 7356 | RSS: Main: 155893760 15:58:18 INFO - PROCESS | 7356 | 15:58:20 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:58:20 INFO - PROCESS | 7356 | RSS: Main: 156672000 15:58:20 INFO - PROCESS | 7356 | 15:58:23 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:58:24 INFO - PROCESS | 7356 | RSS: Main: 156930048 15:58:24 INFO - PROCESS | 7356 | 15:58:26 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:58:27 INFO - PROCESS | 7356 | RSS: Main: 156737536 15:58:27 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | Cycle 1(1): loaded http://localhost:58320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58320/tests/kraken/driver.html?testName=ai-astar) 15:58:29 INFO - PROCESS | 7356 | RSS: Main: 158490624 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | __start_tp_report 15:58:29 INFO - PROCESS | 7356 | _x_x_mozilla_page_load 15:58:29 INFO - PROCESS | 7356 | _x_x_mozilla_page_load_details 15:58:29 INFO - PROCESS | 7356 | |i|pagename|runs| 15:58:29 INFO - PROCESS | 7356 | |0;ai-astar;103;110;103;112;112;112;109;111;110;110 15:58:29 INFO - PROCESS | 7356 | |1;audio-beat-detection;144;117;150;173;117;149;145;122;182;116 15:58:29 INFO - PROCESS | 7356 | |2;audio-dft;163;161;162;161;162;161;161;161;160;162 15:58:29 INFO - PROCESS | 7356 | |3;audio-fft;75;75;75;179;77;75;76;75;157;77 15:58:29 INFO - PROCESS | 7356 | |4;audio-oscillator;83;82;150;85;83;84;140;84;83;146 15:58:29 INFO - PROCESS | 7356 | |5;imaging-gaussian-blur;118;117;116;117;117;118;117;118;118;118 15:58:29 INFO - PROCESS | 7356 | |6;imaging-darkroom;152;148;146;147;148;150;147;148;148;147 15:58:29 INFO - PROCESS | 7356 | |7;imaging-desaturate;96;95;95;96;95;96;96;96;95;95 15:58:29 INFO - PROCESS | 7356 | |8;json-parse-financial;50;50;50;51;50;50;50;51;50;54 15:58:29 INFO - PROCESS | 7356 | |9;json-stringify-tinderbox;60;60;59;59;60;60;60;60;59;60 15:58:29 INFO - PROCESS | 7356 | |10;stanford-crypto-aes;72;76;73;80;78;72;72;73;74;73 15:58:29 INFO - PROCESS | 7356 | |11;stanford-crypto-ccm;128;119;129;128;129;124;121;120;157;135 15:58:29 INFO - PROCESS | 7356 | |12;stanford-crypto-pbkdf2;152;153;155;154;148;150;154;150;151;152 15:58:29 INFO - PROCESS | 7356 | |13;stanford-crypto-sha256-iterative;63;62;62;61;60;62;63;61;60;64 15:58:29 INFO - PROCESS | 7356 | __end_tp_report 15:58:29 INFO - PROCESS | 7356 | __start_cc_report 15:58:29 INFO - PROCESS | 7356 | _x_x_mozilla_cycle_collect,881 15:58:29 INFO - PROCESS | 7356 | __end_cc_report 15:58:29 INFO - PROCESS | 7356 | __startTimestamp1476140309265__endTimestamp 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | ------- Summary: start ------- 15:58:29 INFO - PROCESS | 7356 | Number of tests: 14 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.43 (3.1%) stddev-sans-first:2.80 15:58:29 INFO - PROCESS | 7356 | Values: 103.0 110.0 103.0 112.0 112.0 112.0 109.0 111.0 110.0 110.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.00 stddev:23.59 (16.1%) stddev-sans-first:25.01 15:58:29 INFO - PROCESS | 7356 | Values: 144.0 117.0 150.0 173.0 117.0 149.0 145.0 122.0 182.0 116.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.67 15:58:29 INFO - PROCESS | 7356 | Values: 163.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 160.0 162.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:39.30 (52.4%) stddev-sans-first:41.07 15:58:29 INFO - PROCESS | 7356 | Values: 75.0 75.0 75.0 179.0 77.0 75.0 76.0 75.0 157.0 77.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.00 stddev:30.01 (36.2%) stddev-sans-first:31.03 15:58:29 INFO - PROCESS | 7356 | Values: 83.0 82.0 150.0 85.0 83.0 84.0 140.0 84.0 83.0 146.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:58:29 INFO - PROCESS | 7356 | Values: 118.0 117.0 116.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.73 (1.2%) stddev-sans-first:1.12 15:58:29 INFO - PROCESS | 7356 | Values: 152.0 148.0 146.0 147.0 148.0 150.0 147.0 148.0 148.0 147.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:58:29 INFO - PROCESS | 7356 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.00 stddev:1.26 (2.5%) stddev-sans-first:1.32 15:58:29 INFO - PROCESS | 7356 | Values: 50.0 50.0 50.0 51.0 50.0 50.0 50.0 51.0 50.0 54.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 15:58:29 INFO - PROCESS | 7356 | Values: 60.0 60.0 59.0 59.0 60.0 60.0 60.0 60.0 59.0 60.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.50 stddev:2.79 (3.8%) stddev-sans-first:2.83 15:58:29 INFO - PROCESS | 7356 | Values: 72.0 76.0 73.0 80.0 78.0 72.0 72.0 73.0 74.0 73.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.50 stddev:11.02 (8.6%) stddev-sans-first:11.68 15:58:29 INFO - PROCESS | 7356 | Values: 128.0 119.0 129.0 128.0 129.0 124.0 121.0 120.0 157.0 135.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.50 stddev:2.18 (1.4%) stddev-sans-first:2.32 15:58:29 INFO - PROCESS | 7356 | Values: 152.0 153.0 155.0 154.0 148.0 150.0 154.0 150.0 151.0 152.0 15:58:29 INFO - PROCESS | 7356 | 15:58:29 INFO - PROCESS | 7356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.32 (2.1%) stddev-sans-first:1.32 15:58:29 INFO - PROCESS | 7356 | Values: 63.0 62.0 62.0 61.0 60.0 62.0 63.0 61.0 60.0 64.0 15:58:29 INFO - PROCESS | 7356 | -------- Summary: end -------- 15:58:29 INFO - PROCESS | 7356 | 15:58:30 INFO - TEST-INFO | 7356: exit 0 15:58:30 INFO - TEST-OK | kraken | took 59996ms 15:58:30 INFO - SUITE-END | took 1170s 15:58:30 INFO - Completed test suite (00:19:30) 15:58:30 INFO - javascript benchmark 15:58:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7784.947935859279, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.0, 3282.179455136215, 3283.015095471358, 3303.653116422777, 3305.8512366943487, 5729.3411257705375, 5784.1902133701315, 5808.390119037504, 5820.796272130477, 5825.213596164522, 5631.465010823976, 5751.971240143804, 5776.335721392041, 5799.594028418012, 5808.012637851565, 5201.148707703824, 5266.894662106755, 5292.894142117156, 5314.5748340132695, 5320.813771517997, 5310.0, 5313.309269794921, 5319.281896943901, 5320.122179840322, 5351.117065684158, 5069.898602027957, 5083.313752643383, 5267.973660131714, 5269.736513174326, 5278.498542638443, 5083.18669012958, 5149.047426226122, 5178.870528236786, 5195.896082078375, 5282.894342113136, 5134.0, 5194.065068287707, 5197.740112994373, 5210.062188806013, 5221.373435187764, 5667.263255776764, 5714.799982000652, 5737.340205876336, 5773.653580785124, 5783.103618939072, 5797.652140871562, 5941.168236446901, 6027.276726792769, 6029.397060293979, 6057.212562366908, 6017.097435384683, 6028.3971602839365, 6031.457168854824, 6050.6974651267265, 6053.515718742534, 5602.24369710088, 5620.1569764534825, 5622.57830662702, 5623.8594035149035, 5627.958827616904, 6021.397860213943, 6141.63943600049, 6213.751449942042, 6218.129461875341, 6226.968865155645, 6013.278406591237, 6040.124181993587, 6058.242719660043, 6073.271207455134, 6076.088586712029, 6128.571000030044, 6158.876822463526, 6170.136180934673, 6171.352008039181, 6172.629642221481, 5815.709214539256, 6012.428819262163, 6073.210482637317, 6098.54260930432, 6153.969230153821, 6127.111568822585, 6168.938310616926, 6183.196184495987, 6183.288921773964, 6210.875782484325, 4716.575508204278, 4721.126591580569, 4730.219513780256, 4736.73947932867, 4737.147313483537, 4064.065264989069, 4096.487939007624, 4113.115680128727, 4161.667066634662, 4207.410962465257, 5973.283206015219, 5983.6708981005595, 6012.218411606551, 6014.218151640259, 6019.307779605401, 6184.567080304336, 6228.377162283826, 6231.4391704746795, 6233.625982441068, 6251.499880009588, 5739.885202295931, 5747.3103227612955, 5827.621204621686, 5835.503982161564, 5868.618539794899, 5220.295260139908, 5244.029854476934, 5245.790168393298, 5251.501107394792, 5259.973700131552, 6185.072239164071, 6239.688015599202, 6318.526110541728, 6331.366863313632, 6332.0, 6028.638281703024, 6116.3272040076445, 6138.109974053827, 6178.907316390168, 6189.566730328834, 6378.107065010995, 6406.711697973509, 6416.326285740117, 6421.775237866652, 6421.967890160519, 5861.7655293787775, 6057.242844644419, 6061.1514387984835, 6069.089636554552, 6086.6652334122045, 6028.216331876828, 6031.909521357095, 6062.999605065115, 6129.633877547049, 6136.342068855342, 5989.131575921554, 5999.760009599741, 6004.519638428827, 6004.609700369637, 6039.275286965592, 5762.884742305214, 5937.970310148422, 5984.850378740566, 5988.161657368059, 5989.7304621293015, 5801.6519008859605, 5860.706964651665, 5890.52875769946, 5966.582339236385, 6005.759769609342, 5957.106434034929, 5978.222831032112, 6004.699765011645, 6029.638221706711, 6034.818955431344, 5678.063119585222, 5861.706914654335, 5870.0, 5874.353821079592, 5879.470847623735], "value": 5643.303994657005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5431040943271, 649.6167261315824, 658.7760161545074, 666.273761599856, 669.9631520266383, 35144.0, 45337.1865125395, 45994.770026149905, 46113.53886461134, 46491.302630460574, 49990.25014624783, 50848.49151508484, 50916.23625645609, 50916.236256456184, 50957.0, 9363.719088427359, 9527.190188833958, 9529.094736000068, 9531.428114313128, 9535.713928582154, 9319.813603727922, 9379.343445958752, 9394.62421503139, 9406.811863762721, 9420.199283060949, 9449.858252126223, 9500.572474238641, 9519.80960380792, 9528.190103841147, 9547.904520954771, 9438.197753190987, 9451.952740236324, 9478.90521094787, 9492.52537373132, 9495.66765163223, 9202.30982676302, 9309.767255818591, 9330.486823224719, 9353.76615584609, 9375.437473751597, 46545.76727116343, 47230.52769472296, 47384.28923566149, 47416.05167896657, 47449.76275118637, 3926.6073392660505, 3956.3867600521967, 4054.371572406252, 4387.16643837673, 4743.928841067387, 35529.0, 35635.82182089073, 35758.82120589406, 35961.28071481757, 36116.819415902755, 4783.736894470802, 4857.53853383928, 4908.337374454474, 4994.82518111868, 5060.165072762989, 394472.0, 397262.0, 399261.0, 400264.0, 400542.0, 69341.3065869345, 69575.65212174007, 69666.30333696598, 69674.30325696779, 69881.3011869885, 40634.18731625351, 41739.0, 41862.0, 44053.77973110178, 73218.0, 19553.0, 19991.700124498144, 19992.0, 20000.59998800045, 20007.59984800296, 15060.32228549718, 15243.466478673194, 15280.15959122259, 15313.23433828304, 15385.0, 21163.25928592492, 21324.78675213259, 21451.46371340729, 21628.675569866464, 21678.590891591997, 7714.5756983366455, 7821.960890195513, 7834.764957051298, 7868.567228802471, 7946.205379462123, 1053.942033188182, 1074.8602681651334, 1094.0645747885603, 1129.8700649425257, 1153.8903804138592, 34843.30313393718, 34906.47640285398, 35061.29877402438, 35150.29699406049, 35528.64471355253, 1192.5527927027365, 1196.3121205306984, 1201.3357021642996, 1232.734961983178, 1345.589595173462, 17739.46781596554, 18328.175232114587, 18541.536461588566, 18542.0, 18635.627287454445, 647604.0, 649422.0, 651151.0, 651647.0, 652857.0, 66339.33660663429, 67132.32867671359, 67170.66414667896, 67483.32516674869, 67665.3233467659, 1446.9493567725078, 1453.7310597539702, 1466.0397439677029, 1486.0934829753842, 1486.9107853528824, 34537.309253815285, 34609.48085778665, 34656.306873861875, 34871.65128348785, 35128.648713512535, 58817.70591147017, 58966.41033589609, 59264.40735592589, 59387.406125938185, 59388.0, 487329.0, 492183.0, 492473.0, 493587.0, 494746.0, 32570.83714581412, 32899.177520562174, 32903.506447402826, 33230.16924576905, 33394.33211335711, 55117.0, 55124.448755513535, 55465.722671386386, 56117.43882561122, 57203.42796571981, 44979.0, 47917.76041119772, 48165.0, 48532.64911869049, 48541.75729121332, 47063.294050588585, 47194.52805471901, 47552.762236189985, 47701.76149119232, 48031.75984120057, 47079.52920470889, 50077.74961125171, 50198.49801501938, 51811.0, 52150.478495214564, 45047.32429013502, 48170.759146204044, 48547.5145248543, 48584.271235932196, 49202.50797491979, 36533.33999550346, 37351.0, 37512.43731344087, 37557.2488550222, 38025.429618555194], "value": 22590.90120889912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.6378491250333, 411.9711620186588, 416.16351134220207, 426.15408414297616, 427.3290933234821, 18963.52591185221, 19881.3041543546, 20773.27293544726, 20955.37133885982, 21099.36701898942, 19990.0, 20356.287529936457, 20465.18139274427, 20978.265760698378, 21047.158113675436, 5881.823545293648, 6050.455459008688, 6101.267847858263, 6104.053871649901, 6105.32841387447, 5950.583459157839, 5954.523638108941, 5975.462208401243, 5983.192269043667, 6030.758769649209, 5836.620619659709, 5941.376155503674, 5993.370696076914, 5998.580099393044, 6014.939850601481, 5982.312034116088, 6006.309274433431, 6006.609570377933, 6044.8186554403, 6051.757929682807, 5257.579393648499, 5396.622236443451, 5420.186971954199, 5425.6202065855405, 5433.918491222635, 24034.0, 24829.87585062081, 24910.875445622838, 25015.87492062546, 25310.746892531024, 2634.6179803928517, 2729.372244383783, 2807.7051909549614, 2901.7243361880587, 3109.782315237934, 15439.61400964985, 15510.844891551053, 15543.378264869392, 15631.06213627186, 15669.52991410248, 1912.3593596145308, 1973.8716983396034, 1989.4926793667667, 2006.6488364536149, 2096.3186964236534, 83707.16292837054, 84485.57757211236, 84977.57511212466, 86717.56641216816, 87246.56376718076, 10278.486075696186, 10447.895521044844, 10581.41802200871, 11392.20254582188, 11556.653300401002, 15561.377544898078, 15829.920850395905, 15859.0, 16123.83876161247, 16139.273732682057, 9169.22061624756, 9236.491992940319, 9294.163525282756, 9364.20404265645, 9415.340926135104, 9316.487593182304, 9321.860172097424, 9327.207187389147, 9486.430814151174, 9552.331336806496, 6850.6574671266235, 6946.930530694628, 7084.326988936043, 7128.073350464407, 7136.857262854714, 1999.9200031998557, 2040.4388793081725, 2055.9177632894516, 2075.7612874519623, 2103.8527303088945, 951.2532661860545, 1058.1746237934424, 1064.9148068154684, 1067.6156583629886, 1117.0, 20738.0, 21149.0, 21373.572528549652, 21506.89246553757, 21691.240806571695, 1061.570064124031, 1068.8610480637624, 1073.7906108308962, 1117.3966058328413, 1181.497863408048, 11324.94337528307, 11761.588344407905, 11970.82043769344, 12010.0, 12056.698582535331, 539114.0, 540912.0, 567687.0, 579489.0, 580354.0, 55754.72122639361, 57083.14375284374, 88176.0, 91112.54443727739, 101421.0, 1049.2445439283704, 1070.9036186743074, 1096.4517741129434, 1098.5056724474018, 1106.734383747911, 16392.508224753277, 16785.748213777046, 18311.908440458246, 18559.35042273514, 19014.700079419123, 41996.37005444982, 42130.36804447997, 43758.12483750371, 44236.55763442325, 45088.09823803571, 57492.712536438725, 58120.0, 62262.0, 62946.0, 64285.03572446323, 9216.815663686555, 9406.05939406054, 9411.10594493522, 9415.57629906642, 9489.905100948901, 13728.794068089186, 13832.446702131801, 13998.650033749238, 14006.579802605938, 14206.218657973497, 12511.186772859735, 12606.432710528232, 12651.367431628565, 12760.170588911691, 12861.155598129944, 11602.94198529002, 12186.57346992851, 12262.938685306517, 12279.938600306941, 12943.611691649265, 12101.273923564615, 12566.811497827723, 12588.30764307972, 12706.237625742486, 12925.095243332877, 8688.39181257306, 8938.776530586787, 9010.14403631654, 9027.45835249887, 9514.23886089125, 5345.759440825094, 9217.308701847254, 11408.657740267805, 11446.37044962535, 12682.682932926382], "value": 9924.845416387192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.5691934717952, 1569.18402430736, 1769.4337811900198, 1792.533941175294, 1876.1651065275958, 8118.147594502573, 8656.653733850655, 8791.384603077779, 8831.47011179329, 9147.542622868863, 9103.817923641524, 9250.213731832802, 9258.25933925286, 9278.58246378913, 9330.253579713624, 2483.3295010347197, 2508.849469031855, 2510.134003768697, 2512.5854234051358, 2523.73500782418, 2451.901923923041, 2480.851148931061, 2497.12600589793, 2504.4991001799713, 2505.949881002388, 2457.2430712040887, 2477.4054226985486, 2478.529079474903, 2488.415222422729, 2493.463905260369, 2376.0, 2403.7476065013097, 2405.747396523375, 2409.3976505873534, 2412.9276121716375, 2346.296111166643, 2369.419492224416, 2369.5024044950583, 2409.578323793329, 2416.5287768885073, 9022.052684468103, 9127.497987610679, 9149.085091490864, 9153.221976132038, 9170.082991700843, 5316.707581083039, 5456.208849716809, 5468.64453810505, 5473.124300112003, 5475.808346707846, 3422.2625763078627, 3460.740444466675, 3490.493878387645, 3514.437689969618, 3568.07230120168, 1281.609109221687, 1312.3372696788156, 1325.7481078595035, 1339.8794108530278, 1372.1492674541748, 12415.62753117408, 12543.686407839878, 12548.24710517372, 12564.685882852911, 12565.434555444936, 4635.536446355405, 4685.81256749733, 4755.072760811678, 4758.738269395148, 4789.928151077667, 9975.0, 10004.449755263531, 10017.04838040385, 10033.14718248957, 10045.397276163454, 5459.863503412446, 5474.972625136849, 5477.452254774491, 5492.47821456961, 5493.670379777146, 4443.089166720814, 4992.226204938241, 5119.488051194925, 5161.974190129101, 5170.97414512925, 3896.7661940283674, 3924.175923056133, 3938.113924367052, 4018.6985976051915, 4032.1330913853662, 1133.438947720867, 1141.577616281981, 1156.9595064172713, 1157.7684463107244, 1159.47244003978, 948.672707915768, 983.2379905573238, 984.5471083301618, 996.7657600463886, 1002.9598816047422, 5763.3084029915835, 6150.50795936333, 6367.777127800505, 6462.741490340428, 6482.416582507597, 481.37421352241944, 491.41030763084444, 495.6679025053223, 510.6093838213769, 511.20507610665027, 4317.158154159972, 4415.823367065282, 4422.845200418034, 4433.512313645497, 4561.657875659273, 10782.622608208674, 11251.718707032389, 11293.54825806975, 11296.096312294996, 11304.604338848265, 10815.67552973412, 10882.0, 11047.0, 11163.497642606102, 11189.776204475866, 8351.24838764514, 8355.456895301786, 8373.455725377831, 8374.748757537283, 8378.539180345018, 6099.115628233792, 6103.633781973096, 6199.845003874759, 6209.534284928739, 6343.746250149942, 9937.801243975224, 10000.59997600117, 10135.0, 10329.845052324372, 10461.372317660966, 10527.420991845522, 10607.681769546925, 10658.467076646291, 10670.786584268117, 10720.0, 8302.0, 8578.313734901069, 8588.914110858812, 8689.522076285864, 8877.955610221907, 8918.0, 8945.955270223867, 8991.325650576364, 9007.0, 9028.59371328305, 7739.032620922385, 7797.103333116765, 7819.569923654026, 7956.164602716863, 8326.29226515753, 7618.96190519066, 7688.384929205762, 7703.730369437043, 7710.26752458538, 7916.366690664848, 7400.777976660709, 7438.73964411243, 7491.662875170739, 7500.362469189961, 7530.849383012419, 5378.381486128988, 5426.186072089218, 5483.588730845123, 5504.724763761876, 5552.611317207757, 5239.921401179062, 5292.0738870696705, 5304.814331498379, 5350.090484617546, 5367.704776237344], "value": 4731.551222457432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.51417529633807, 351.79771631311985, 353.69228770969255, 358.4605169220323, 362.526902392378, 5774.238857148568, 5785.3925337839555, 5807.274090738658, 5827.184194212814, 5844.941550584493, 5669.829905102843, 5699.202111704354, 5730.598858079936, 5744.770209191627, 5758.596898217126, 4173.728707634002, 4407.933880991788, 4416.536263692315, 4419.955800442002, 4494.775261236925, 4457.687961842672, 4470.463544374679, 4493.168763778712, 4502.57225563571, 4512.85639321323, 4276.850310239142, 4421.491528474218, 4424.867253982369, 4476.187144206601, 4491.30384790358, 4395.7362558246605, 4413.271810151321, 4414.293713005935, 4422.137683151771, 4434.8669539913535, 3868.729188956774, 3873.98063009686, 3878.9635441393493, 3894.7663140211394, 3900.3369427197445, 5502.9174562381595, 5556.277683901067, 5592.217089607459, 5607.5607110906885, 5640.8307750767135, 5043.924341134886, 5083.847484575469, 5087.872803179913, 5091.46539613339, 5098.209777484496, 5866.941330586682, 5928.02187639039, 5982.4316689914385, 5986.132010858445, 5989.610675306135, 4217.240896638604, 4300.742110392038, 4309.59058889405, 4342.565743425664, 4368.956310436887, 6213.130161777355, 6226.1905952225925, 6276.152719382871, 6307.936920630781, 6333.176687030703, 4464.218761716752, 4465.553444655508, 4466.062126953311, 4471.754053527022, 4472.843450479218, 4263.317869140985, 4480.417545719036, 4493.842955381435, 4523.36672865799, 4543.795529201194, 5081.441041485434, 5081.59347252219, 5102.515261050195, 5109.0, 5126.7180305083575, 6035.275766907999, 6039.829089727928, 6061.605995610271, 6087.452129308295, 6119.449249567471, 1473.6463248820205, 1527.152430401138, 1537.9077255364714, 1554.8134223893205, 1555.7510798272222, 962.2782912815388, 974.1670871404989, 983.8622592837008, 990.9693918324862, 993.8161440133598, 5201.479852014844, 5208.229202071238, 5219.817306394258, 5225.033368826779, 5245.793467502496, 5422.7017514036315, 5441.727913604304, 5442.374126975448, 5446.945530544644, 5487.972560137254, 5240.737963101829, 5723.283015095455, 6002.369751176151, 6010.188624535719, 6013.0, 3308.652591477908, 3338.7662863599317, 3344.5317655528247, 3346.728243267543, 3353.815540145267, 6261.749530018839, 6417.74329026843, 6461.870762584722, 6526.28210896801, 6547.333493243798, 6366.363363663597, 6375.71309291083, 6377.7448902044325, 6389.744410223539, 6427.903581446282, 6329.082283068929, 6445.035283769518, 6511.316311787289, 6560.770373037016, 6577.144971153815, 6184.628922264678, 6186.597871138361, 6227.16298691896, 6247.250329960434, 6257.530685198537, 6146.53900957439, 6173.6913154343, 6180.845478863064, 6182.567220294716, 6209.658468784261, 6207.441330280297, 6404.327545607644, 6454.451371633464, 6454.774082907075, 6456.225252969673, 4368.475782906072, 4401.4278143842375, 4403.053343531028, 4416.094700586436, 4423.977880110579, 5997.580169388101, 6171.444569988723, 6232.844178895564, 6239.847252697812, 6275.0, 6000.759969601167, 6031.215941927697, 6062.999210260516, 6100.261425493713, 6116.908246376397, 6040.275166979991, 6042.063480160582, 6050.878982420415, 6058.061420345447, 6092.268927728701, 5801.941980580309, 5963.389884731185, 5968.850778730392, 5980.312264089512, 6008.759649613967, 6007.339192688888, 6052.697365131814, 6060.696965151813, 6093.542984276109, 6126.5711400203345, 5780.161876527795, 5876.500497457593, 5917.437843404869, 5971.28344598651, 5981.641101533748], "value": 4570.187453959496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.0927723840344, 785.112822510563, 800.8158123631565, 877.7410663854166, 915.0529202275646, 15800.44698435555, 16388.098654573994, 16850.915745421287, 16855.83144168558, 17838.910805445987, 15421.614459638515, 15596.0, 15666.0, 15711.764323535128, 15766.054036757774, 868.7133246028811, 873.3362644390246, 888.4447220487195, 889.8220355928808, 904.2585080234211, 903.7966457547066, 903.9276857851389, 905.1853332001185, 911.1617312072909, 911.2436677557645, 954.5179684259439, 954.5322791831987, 954.9952250238739, 955.8852937647492, 958.0850287975002, 945.6122989574276, 949.7625593601599, 951.7620594851287, 954.7708549947962, 955.44106697582, 700.250731717063, 702.2661318921688, 702.9086218791575, 703.7290643102391, 703.7747920665389, 15444.305006274744, 15455.072695638297, 15503.379864805394, 15509.146996915166, 15510.767338489932, 15306.311215995307, 15364.769528457082, 15620.531384058497, 15731.606709832231, 16279.023258604404, 14556.927215363961, 14755.631109222248, 14769.92615036918, 14772.187529685863, 15046.849531504655, 4841.685290456145, 4881.780319885614, 4888.0957022950515, 4966.0, 5140.177571588528, 91712.0, 92308.53845730795, 92395.53802231012, 92566.53716731441, 93866.5306673469, 12639.747205056032, 12696.555620553236, 12710.110292279636, 12715.173513721578, 12783.424745886457, 21258.043388047576, 22931.42671433194, 22932.426689332566, 22937.770622293898, 22945.426364341027, 9505.762355941157, 9594.952025239969, 9639.951800240953, 9642.807143857084, 9715.61137554504, 5110.156824124052, 5136.691798492103, 5221.986787984544, 5311.468853114658, 5387.973060134675, 3920.0, 4010.137820368635, 4023.517177938666, 4034.23349563582, 4040.575739547305, 665.7270519087151, 671.9932800672028, 672.1463741048841, 677.2854638356581, 680.897865320196, 744.817519707675, 788.2157253532772, 800.5756948817136, 826.7726375246855, 878.5168157513342, 10708.94645526783, 10709.946450267698, 10796.460176991119, 10815.729606759895, 11670.440515642811, 675.6621689155422, 679.7111227728195, 686.2931180883697, 740.5556666000357, 826.5371392020488, 4833.419989601271, 5069.797208111708, 5143.408508021551, 5233.319668443154, 5249.658772179796, 65943.67028164829, 66581.33418665848, 69729.0, 70051.64974175199, 70146.0, 105305.0, 105456.0, 105798.471007646, 106346.46826765971, 107294.0, 93225.53387233157, 93636.0, 95693.52153239328, 95998.56271646594, 97731.0, 9753.707388778348, 10153.39079655223, 10192.694219173436, 10201.38791672502, 10237.48812559384, 52141.0, 52612.47387526076, 52899.471005290994, 53063.0, 56479.71760141173, 50143.74928125336, 52780.73609631927, 68961.3103868955, 74517.0, 74777.62611186909, 13216.074874759059, 13710.65723356924, 13735.725285494034, 13971.510997115052, 14693.853061469676, 16228.756568651715, 16308.510744677678, 16348.918255408647, 16732.0, 17370.652586948443, 14145.717085658434, 14169.0, 14434.639134021734, 15396.0, 15479.148646824533, 14454.0, 14653.560393188221, 14796.704065918406, 14942.103473791607, 14950.700985980437, 14690.485832995793, 14712.852871471148, 15272.389104435699, 15313.693726125191, 16190.919045404698, 11365.782727967635, 11546.884531154918, 11595.536178552764, 11684.0, 12042.337671427806, 10894.61868834587, 11607.941960290145, 11698.94150529242, 11911.583094591648, 13125.081244312807], "value": 8135.056084815897, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 103.0, 112.0, 112.0, 112.0, 109.0, 111.0, 110.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 150.0, 173.0, 117.0, 149.0, 145.0, 122.0, 182.0, 116.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 179.0, 77.0, 75.0, 76.0, 75.0, 157.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 150.0, 85.0, 83.0, 84.0, 140.0, 84.0, 83.0, 146.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 146.0, 147.0, 148.0, 150.0, 147.0, 148.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 51.0, 50.0, 50.0, 50.0, 51.0, 50.0, 54.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 73.0, 80.0, 78.0, 72.0, 72.0, 73.0, 74.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 129.0, 128.0, 129.0, 124.0, 121.0, 120.0, 157.0, 135.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 155.0, 154.0, 148.0, 150.0, 154.0, 150.0, 151.0, 152.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 60.0, 62.0, 63.0, 61.0, 60.0, 64.0], "value": 61.8, "unit": "score"}]}]} 15:58:30 INFO - Return code: 0 15:58:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:58:30 ERROR - # TBPL SUCCESS # 15:58:30 INFO - Running post-action listener: _resource_record_post_action 15:58:30 INFO - [mozharness: 2016-10-10 22:58:30.580522Z] Finished run-tests step (success) 15:58:30 INFO - Running post-run listener: _resource_record_post_run 15:58:30 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292724736; Read time: 12; Write time: 159012 15:58:30 INFO - TinderboxPrint: CPU usage
13.2% 15:58:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:58:30 INFO - TinderboxPrint: I/O write bytes / time
292,724,736 / 159,012 15:58:30 INFO - TinderboxPrint: CPU idle
8,210.0 (86.8%) 15:58:30 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 15:58:30 INFO - TinderboxPrint: Swap in / out
0 / 0 15:58:30 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71372800; Read time: 0; Write time: 51840 15:58:30 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 221351936; Read time: 0; Write time: 107172 15:58:31 INFO - Running post-run listener: _upload_blobber_files 15:58:31 INFO - Blob upload gear active. 15:58:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:58:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:58:31 INFO - (blobuploader) - INFO - Open directory for files ... 15:58:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:58:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:58:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:32 INFO - (blobuploader) - INFO - Done attempting. 15:58:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:58:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:33 INFO - (blobuploader) - INFO - Done attempting. 15:58:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:58:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:58:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:36 INFO - (blobuploader) - INFO - Done attempting. 15:58:36 INFO - (blobuploader) - INFO - Iteration through files over. 15:58:36 INFO - Return code: 0 15:58:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:58:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:58:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/263d240451c8254f403206ec673afa2d609a6e0a41bbf29fcdcdee0efd35c9c576ad0d227f35c9ce1843d54c173bbef9f1daabd5abb10faada92193811265564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fecce4fa9da60778e98a8bbbabef771f8908a278194df13f1f99e669921d496ef5a619173fa82e4b026259b2db5fcd1404f955f935628d3106f3252f0287dd55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/367c4cad6f1d06e9c18aaaca9d0f7a015bdefa72d879709c59e169f375d53308c77e528b88d14189237d8e3d2d7312e71147c2f8833d2ef0a224af1249a4cb21"} 15:58:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:58:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:58:36 INFO - Contents: 15:58:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/263d240451c8254f403206ec673afa2d609a6e0a41bbf29fcdcdee0efd35c9c576ad0d227f35c9ce1843d54c173bbef9f1daabd5abb10faada92193811265564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fecce4fa9da60778e98a8bbbabef771f8908a278194df13f1f99e669921d496ef5a619173fa82e4b026259b2db5fcd1404f955f935628d3106f3252f0287dd55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/367c4cad6f1d06e9c18aaaca9d0f7a015bdefa72d879709c59e169f375d53308c77e528b88d14189237d8e3d2d7312e71147c2f8833d2ef0a224af1249a4cb21"} 15:58:36 INFO - Running post-run listener: copy_logs_to_upload_dir 15:58:36 INFO - Copying logs to upload dir... 15:58:36 INFO - mkdir: /builds/slave/test/build/upload/logs 15:58:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1671.803796 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-10-10 15:58:35.744330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 15:58:35.748087) ========= 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=62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/263d240451c8254f403206ec673afa2d609a6e0a41bbf29fcdcdee0efd35c9c576ad0d227f35c9ce1843d54c173bbef9f1daabd5abb10faada92193811265564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fecce4fa9da60778e98a8bbbabef771f8908a278194df13f1f99e669921d496ef5a619173fa82e4b026259b2db5fcd1404f955f935628d3106f3252f0287dd55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/367c4cad6f1d06e9c18aaaca9d0f7a015bdefa72d879709c59e169f375d53308c77e528b88d14189237d8e3d2d7312e71147c2f8833d2ef0a224af1249a4cb21"} build_url:https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/EP_Hd_WqQ_CIxoqJowJdMQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/263d240451c8254f403206ec673afa2d609a6e0a41bbf29fcdcdee0efd35c9c576ad0d227f35c9ce1843d54c173bbef9f1daabd5abb10faada92193811265564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fecce4fa9da60778e98a8bbbabef771f8908a278194df13f1f99e669921d496ef5a619173fa82e4b026259b2db5fcd1404f955f935628d3106f3252f0287dd55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/367c4cad6f1d06e9c18aaaca9d0f7a015bdefa72d879709c59e169f375d53308c77e528b88d14189237d8e3d2d7312e71147c2f8833d2ef0a224af1249a4cb21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 15:58:35.775325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:58:35.775644) ========= 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=62c568580acbfdaac3eec7be000001dc-1476138643.225007-284136401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 15:58:35.859120) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 15:58:35.859648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 15:58:35.860024) ========= ========= Total master_lag: 0.17 =========