builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1472382343.54 results: success (0) buildid: 20160826110814 builduid: 0dbeb50956e042d4ac8dadee4f76f40d revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.541281) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.541776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.542105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.556789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.557128) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-28 04:05:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-28 04:05:44 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.709193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.709506) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019993 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:43.758895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-28 04:05:43.759261) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f --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 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f --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=20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-28 04:05:44,356 truncating revision to first 12 chars 2016-08-28 04:05:44,356 Setting DEBUG logging. 2016-08-28 04:05:44,357 attempt 1/10 2016-08-28 04:05:44,357 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6d0c7b6a6ae1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-28 04:05:45,493 unpacking tar archive at: mozilla-beta-6d0c7b6a6ae1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-28 04:05:45.239132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:45.239627) ========= script_repo_revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:45.240262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:45.240712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:45.252619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 49 secs) (at 2016-08-28 04:05:45.253010) ========= /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=20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:45 INFO - MultiFileLogger online at 20160828 04:05:45 in /builds/slave/test 04:05:45 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 04:05:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:45 INFO - {'append_to_log': False, 04:05:45 INFO - 'base_work_dir': '/builds/slave/test', 04:05:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:05:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:45 INFO - 'branch': 'Mozilla-Beta', 04:05:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:45 INFO - 'config_files': ('talos/linux_config.py',), 04:05:45 INFO - 'default_actions': ('clobber', 04:05:45 INFO - 'read-buildbot-config', 04:05:45 INFO - 'download-and-extract', 04:05:45 INFO - 'populate-webroot', 04:05:45 INFO - 'create-virtualenv', 04:05:45 INFO - 'install', 04:05:45 INFO - 'run-tests'), 04:05:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:45 INFO - 'download_minidump_stackwalk': True, 04:05:45 INFO - 'download_symbols': 'ondemand', 04:05:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:45 INFO - 'installer_path': 'installer.exe', 04:05:45 INFO - 'log_level': 'info', 04:05:45 INFO - 'log_name': 'talos', 04:05:45 INFO - 'log_to_console': True, 04:05:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:45 INFO - 'opt_config_files': (), 04:05:45 INFO - 'pip_index': False, 04:05:45 INFO - 'sps_profile': False, 04:05:45 INFO - 'sps_profile_interval': 0, 04:05:45 INFO - 'suite': 'dromaeojs-e10s', 04:05:45 INFO - 'system_bits': '32', 04:05:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:45 INFO - 'title': 'talos-linux64-ix-015', 04:05:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:45 INFO - 'use_talos_json': True, 04:05:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:45 INFO - 'work_dir': 'build'} 04:05:45 INFO - ##### 04:05:45 INFO - ##### Running clobber step. 04:05:45 INFO - ##### 04:05:45 INFO - Running pre-action listener: _resource_record_pre_action 04:05:45 INFO - Running main action method: clobber 04:05:45 INFO - rmtree: /builds/slave/test/build 04:05:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:46 INFO - Running post-action listener: _resource_record_post_action 04:05:46 INFO - ##### 04:05:46 INFO - ##### Finished clobber step (success) 04:05:46 INFO - ##### 04:05:46 INFO - ##### 04:05:46 INFO - ##### Running read-buildbot-config step. 04:05:46 INFO - ##### 04:05:46 INFO - Running pre-action listener: _resource_record_pre_action 04:05:46 INFO - Running main action method: read_buildbot_config 04:05:46 INFO - Using buildbot properties: 04:05:46 INFO - { 04:05:46 INFO - "project": "", 04:05:46 INFO - "product": "firefox", 04:05:46 INFO - "script_repo_revision": "production", 04:05:46 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:05:46 INFO - "repository": "", 04:05:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:05:46 INFO - "buildid": "20160826110814", 04:05:46 INFO - "pgo_build": "True", 04:05:46 INFO - "basedir": "/builds/slave/test", 04:05:46 INFO - "buildnumber": 153, 04:05:46 INFO - "slavename": "talos-linux64-ix-015", 04:05:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:46 INFO - "platform": "ubuntu64_hw", 04:05:46 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:05:46 INFO - "branch": "mozilla-beta", 04:05:46 INFO - "repo_path": "releases/mozilla-beta", 04:05:46 INFO - "revision": "6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f", 04:05:46 INFO - "stage_platform": "linux64-pgo", 04:05:46 INFO - "builduid": "0dbeb50956e042d4ac8dadee4f76f40d", 04:05:46 INFO - "slavebuilddir": "test" 04:05:46 INFO - } 04:05:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 04:05:46 INFO - Running post-action listener: _resource_record_post_action 04:05:46 INFO - ##### 04:05:46 INFO - ##### Finished read-buildbot-config step (success) 04:05:46 INFO - ##### 04:05:46 INFO - ##### 04:05:46 INFO - ##### Running download-and-extract step. 04:05:46 INFO - ##### 04:05:46 INFO - Running pre-action listener: _resource_record_pre_action 04:05:46 INFO - Running main action method: download_and_extract 04:05:46 INFO - mkdir: /builds/slave/test/build/tests 04:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:46 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:05:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:05:46 INFO - retry: Failed, sleeping 30 seconds before retrying 04:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 04:06:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:06:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:06:16 INFO - retry: Failed, sleeping 60 seconds before retrying 04:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 04:07:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:07:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json! 04:07:16 INFO - Caught exception: HTTP Error 404: Not Found 04:07:16 INFO - Caught exception: HTTP Error 404: Not Found 04:07:16 INFO - Caught exception: HTTP Error 404: Not Found 04:07:16 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:16 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:07:17 INFO - Downloaded 1327 bytes. 04:07:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:17 INFO - Using the following test package requirements: 04:07:17 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:17 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:17 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 04:07:17 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'jsshell-linux-x86_64.zip'], 04:07:17 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:17 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:17 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 04:07:17 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 04:07:17 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:17 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:17 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:17 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:17 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:07:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:07:17 INFO - retry: Failed, sleeping 30 seconds before retrying 04:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 04:07:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:07:47 INFO - retry: Failed, sleeping 60 seconds before retrying 04:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 04:08:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:08:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 04:08:47 INFO - Caught exception: HTTP Error 404: Not Found 04:08:47 INFO - Caught exception: HTTP Error 404: Not Found 04:08:47 INFO - Caught exception: HTTP Error 404: Not Found 04:08:47 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:47 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:48 INFO - Downloaded 21969046 bytes. 04:08:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:08:49 INFO - Return code: 0 04:08:49 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:08:49 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 04:09:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:09:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:09:19 INFO - retry: Failed, sleeping 60 seconds before retrying 04:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 04:10:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:10:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:10:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 04:10:19 INFO - Caught exception: HTTP Error 404: Not Found 04:10:19 INFO - Caught exception: HTTP Error 404: Not Found 04:10:19 INFO - Caught exception: HTTP Error 404: Not Found 04:10:19 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:10:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:10:20 INFO - Downloaded 21969046 bytes. 04:10:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:10:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:10:21 INFO - Return code: 0 04:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:21 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:10:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:10:21 INFO - retry: Failed, sleeping 30 seconds before retrying 04:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 04:10:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:10:51 INFO - retry: Failed, sleeping 60 seconds before retrying 04:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 04:11:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:11:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:11:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip! 04:11:51 INFO - Caught exception: HTTP Error 404: Not Found 04:11:51 INFO - Caught exception: HTTP Error 404: Not Found 04:11:51 INFO - Caught exception: HTTP Error 404: Not Found 04:11:51 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:11:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:11:52 INFO - Downloaded 10833369 bytes. 04:11:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:11:52 INFO - Return code: 0 04:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:52 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:11:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:11:52 INFO - retry: Failed, sleeping 30 seconds before retrying 04:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 04:12:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:12:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:12:22 INFO - retry: Failed, sleeping 60 seconds before retrying 04:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 04:13:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:13:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2! 04:13:22 INFO - Caught exception: HTTP Error 404: Not Found 04:13:22 INFO - Caught exception: HTTP Error 404: Not Found 04:13:22 INFO - Caught exception: HTTP Error 404: Not Found 04:13:22 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:22 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:23 INFO - Downloaded 55208267 bytes. 04:13:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:23 INFO - mkdir: /builds/slave/test/properties 04:13:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:23 INFO - Contents: 04:13:23 INFO - build_url:https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:24 INFO - Running post-action listener: _resource_record_post_action 04:13:24 INFO - Running post-action listener: set_extra_try_arguments 04:13:24 INFO - ##### 04:13:24 INFO - ##### Finished download-and-extract step (success) 04:13:24 INFO - ##### 04:13:24 INFO - ##### 04:13:24 INFO - ##### Running populate-webroot step. 04:13:24 INFO - ##### 04:13:24 INFO - Running pre-action listener: _resource_record_pre_action 04:13:24 INFO - Running main action method: populate_webroot 04:13:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:24 INFO - '--tppagecycles', 04:13:24 INFO - '7'], 04:13:24 INFO - 'tests': ['tsvgm']}}, 04:13:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['damp', 'tps']}, 04:13:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'tests': ['damp', 'tps']}, 04:13:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['dromaeo_dom']}, 04:13:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['a11yr', 04:13:24 INFO - 'ts_paint', 04:13:24 INFO - 'tpaint', 04:13:24 INFO - 'sessionrestore', 04:13:24 INFO - 'sessionrestore_no_auto_restore', 04:13:24 INFO - 'tabpaint']}, 04:13:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:24 INFO - 'ts_paint', 04:13:24 INFO - 'tpaint', 04:13:24 INFO - 'sessionrestore', 04:13:24 INFO - 'sessionrestore_no_auto_restore', 04:13:24 INFO - 'tabpaint']}, 04:13:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:24 INFO - 'ts_paint', 04:13:24 INFO - 'tpaint', 04:13:24 INFO - 'sessionrestore', 04:13:24 INFO - 'sessionrestore_no_auto_restore', 04:13:24 INFO - 'tabpaint']}, 04:13:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:24 INFO - 'ts_paint', 04:13:24 INFO - 'tpaint', 04:13:24 INFO - 'sessionrestore', 04:13:24 INFO - 'sessionrestore_no_auto_restore', 04:13:24 INFO - 'tabpaint']}, 04:13:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['a11yr', 04:13:24 INFO - 'ts_paint', 04:13:24 INFO - 'tpaint', 04:13:24 INFO - 'sessionrestore', 04:13:24 INFO - 'sessionrestore_no_auto_restore', 04:13:24 INFO - 'tabpaint']}, 04:13:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['a11yr', 04:13:24 INFO - 'ts_paint', 04:13:24 INFO - 'tpaint', 04:13:24 INFO - 'sessionrestore', 04:13:24 INFO - 'sessionrestore_no_auto_restore', 04:13:24 INFO - 'tabpaint']}, 04:13:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['tsvgx', 04:13:24 INFO - 'tsvgr_opacity', 04:13:24 INFO - 'tart', 04:13:24 INFO - 'tscrollx', 04:13:24 INFO - 'cart']}, 04:13:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:24 INFO - 'tsvgr_opacity', 04:13:24 INFO - 'tart', 04:13:24 INFO - 'tscrollx', 04:13:24 INFO - 'cart']}, 04:13:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'talos_options': ['--disable-e10s'], 04:13:24 INFO - 'tests': ['tp5o']}, 04:13:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'tests': ['tp5o']}, 04:13:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'talos_options': ['--disable-e10s', 04:13:24 INFO - '--xperf_path', 04:13:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:24 INFO - 'tests': ['tp5n']}, 04:13:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:24 INFO - 'talos_options': ['--xperf_path', 04:13:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:24 INFO - 'tests': ['tp5n']}}, 04:13:24 INFO - 'talos.zip': {'path': '', 04:13:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:24 INFO - Running post-action listener: _resource_record_post_action 04:13:24 INFO - ##### 04:13:24 INFO - ##### Finished populate-webroot step (success) 04:13:24 INFO - ##### 04:13:24 INFO - ##### 04:13:24 INFO - ##### Running create-virtualenv step. 04:13:24 INFO - ##### 04:13:24 INFO - Running pre-action listener: _resource_record_pre_action 04:13:24 INFO - Running main action method: create_virtualenv 04:13:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:24 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 04:13:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:24 INFO - Using real prefix '/usr' 04:13:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:27 INFO - Installing pip.................done. 04:13:27 INFO - Return code: 0 04:13:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13:27 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 04:13:27 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 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:27 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 04:13:27 INFO - Cleaning up... 04:13:27 INFO - Return code: 0 04:13:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:27 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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13:27 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 04:13:27 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 04:13:27 INFO - Using env: {'DISPLAY': ':0', 04:13:27 INFO - 'HOME': '/home/cltbld', 04:13:27 INFO - 'LANG': 'en_US.UTF-8', 04:13:27 INFO - 'LANGUAGE': 'en_US:en', 04:13:27 INFO - 'LOGNAME': 'cltbld', 04:13:27 INFO - 'MAIL': '/var/mail/cltbld', 04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:27 INFO - 'MOZ_NO_REMOTE': '1', 04:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:27 INFO - 'NO_EM_RESTART': '1', 04:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:27 INFO - 'PWD': '/builds/slave/test', 04:13:27 INFO - 'SHELL': '/bin/bash', 04:13:27 INFO - 'SHLVL': '1', 04:13:27 INFO - 'TERM': 'linux', 04:13:27 INFO - 'TMOUT': '86400', 04:13:27 INFO - 'USER': 'cltbld', 04:13:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:27 INFO - '_': '/tools/buildbot/bin/python'} 04:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:27 INFO - Downloading/unpacking psutil>=3.1.1 04:13:27 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 04:13:27 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 04:13:27 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 04:13:27 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 04:13:27 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 04:13:27 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 04:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:29 INFO - Installing collected packages: psutil 04:13:29 INFO - Running setup.py install for psutil 04:13:29 INFO - building 'psutil._psutil_linux' extension 04:13:29 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 04:13: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:13:29 INFO - building 'psutil._psutil_posix' extension 04:13:29 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 04:13: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 04:13:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:29 INFO - Successfully installed psutil 04:13:29 INFO - Cleaning up... 04:13:29 INFO - Return code: 0 04:13:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13:30 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 04:13:30 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 04:13:30 INFO - Using env: {'DISPLAY': ':0', 04:13:30 INFO - 'HOME': '/home/cltbld', 04:13:30 INFO - 'LANG': 'en_US.UTF-8', 04:13:30 INFO - 'LANGUAGE': 'en_US:en', 04:13:30 INFO - 'LOGNAME': 'cltbld', 04:13:30 INFO - 'MAIL': '/var/mail/cltbld', 04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:30 INFO - 'MOZ_NO_REMOTE': '1', 04:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:30 INFO - 'NO_EM_RESTART': '1', 04:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:30 INFO - 'PWD': '/builds/slave/test', 04:13:30 INFO - 'SHELL': '/bin/bash', 04:13:30 INFO - 'SHLVL': '1', 04:13:30 INFO - 'TERM': 'linux', 04:13:30 INFO - 'TMOUT': '86400', 04:13:30 INFO - 'USER': 'cltbld', 04:13:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:30 INFO - '_': '/tools/buildbot/bin/python'} 04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:32 INFO - Installing collected packages: mozsystemmonitor 04:13:32 INFO - Running setup.py install for mozsystemmonitor 04:13:32 INFO - Successfully installed mozsystemmonitor 04:13:32 INFO - Cleaning up... 04:13:32 INFO - Return code: 0 04:13:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:13:32 INFO - Using env: {'DISPLAY': ':0', 04:13:32 INFO - 'HOME': '/home/cltbld', 04:13:32 INFO - 'LANG': 'en_US.UTF-8', 04:13:32 INFO - 'LANGUAGE': 'en_US:en', 04:13:32 INFO - 'LOGNAME': 'cltbld', 04:13:32 INFO - 'MAIL': '/var/mail/cltbld', 04:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:32 INFO - 'MOZ_NO_REMOTE': '1', 04:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:32 INFO - 'NO_EM_RESTART': '1', 04:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:32 INFO - 'PWD': '/builds/slave/test', 04:13:32 INFO - 'SHELL': '/bin/bash', 04:13:32 INFO - 'SHLVL': '1', 04:13:32 INFO - 'TERM': 'linux', 04:13:32 INFO - 'TMOUT': '86400', 04:13:32 INFO - 'USER': 'cltbld', 04:13:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:32 INFO - '_': '/tools/buildbot/bin/python'} 04:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:34 INFO - warning: no files found matching '*.txt' 04:13:34 INFO - no previously-included directories found matching 'build' 04:13:34 INFO - no previously-included directories found matching 'dist' 04:13:34 INFO - no previously-included directories found matching '.git*' 04:13:34 INFO - Installing collected packages: jsonschema, functools32 04:13:34 INFO - Running setup.py install for functools32 04:13:34 INFO - warning: no files found matching '*.txt' 04:13:34 INFO - no previously-included directories found matching 'build' 04:13:34 INFO - no previously-included directories found matching 'dist' 04:13:34 INFO - no previously-included directories found matching '.git*' 04:13:34 INFO - Successfully installed jsonschema functools32 04:13:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13: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 04:13: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 04:13:34 INFO - Using env: {'DISPLAY': ':0', 04:13:34 INFO - 'HOME': '/home/cltbld', 04:13:34 INFO - 'LANG': 'en_US.UTF-8', 04:13:34 INFO - 'LANGUAGE': 'en_US:en', 04:13:34 INFO - 'LOGNAME': 'cltbld', 04:13:34 INFO - 'MAIL': '/var/mail/cltbld', 04:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:34 INFO - 'MOZ_NO_REMOTE': '1', 04:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:34 INFO - 'NO_EM_RESTART': '1', 04:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:34 INFO - 'PWD': '/builds/slave/test', 04:13:34 INFO - 'SHELL': '/bin/bash', 04:13:34 INFO - 'SHLVL': '1', 04:13:34 INFO - 'TERM': 'linux', 04:13:34 INFO - 'TMOUT': '86400', 04:13:34 INFO - 'USER': 'cltbld', 04:13:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:34 INFO - '_': '/tools/buildbot/bin/python'} 04:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:35 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:35 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 04:13:35 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 04:13:35 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 04:13:35 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 04:13:35 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 04:13:35 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 04:13:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:37 INFO - Downloading docopt-0.6.1.tar.gz 04:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:37 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:37 INFO - Running setup.py install for blobuploader 04:13:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:37 INFO - Running setup.py install for requests 04:13:38 INFO - Running setup.py install for docopt 04:13:38 INFO - Successfully installed blobuploader requests docopt 04:13:38 INFO - Cleaning up... 04:13:38 INFO - Return code: 0 04:13:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:38 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')]} 04:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:38 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')]} 04:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:38 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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13:38 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 04:13:38 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 04:13:38 INFO - Using env: {'DISPLAY': ':0', 04:13:38 INFO - 'HOME': '/home/cltbld', 04:13:38 INFO - 'LANG': 'en_US.UTF-8', 04:13:38 INFO - 'LANGUAGE': 'en_US:en', 04:13:38 INFO - 'LOGNAME': 'cltbld', 04:13:38 INFO - 'MAIL': '/var/mail/cltbld', 04:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:38 INFO - 'MOZ_NO_REMOTE': '1', 04:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:38 INFO - 'NO_EM_RESTART': '1', 04:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:38 INFO - 'PWD': '/builds/slave/test', 04:13:38 INFO - 'SHELL': '/bin/bash', 04:13:38 INFO - 'SHLVL': '1', 04:13:38 INFO - 'TERM': 'linux', 04:13:38 INFO - 'TMOUT': '86400', 04:13:38 INFO - 'USER': 'cltbld', 04:13:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:38 INFO - '_': '/tools/buildbot/bin/python'} 04:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:38 INFO - Running setup.py (path:/tmp/pip-jcTlie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:38 INFO - Running setup.py (path:/tmp/pip-gHU2UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:38 INFO - Running setup.py (path:/tmp/pip-NkHtlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:38 INFO - Running setup.py (path:/tmp/pip-jRrjuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:38 INFO - Running setup.py (path:/tmp/pip-sRXMgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:38 INFO - Running setup.py (path:/tmp/pip-tJLMFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:39 INFO - Running setup.py (path:/tmp/pip-uFYiUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:39 INFO - Running setup.py (path:/tmp/pip-uRohWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:39 INFO - Running setup.py (path:/tmp/pip-Nt5Zv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:39 INFO - Running setup.py (path:/tmp/pip-sZZAkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:39 INFO - Running setup.py (path:/tmp/pip-RbqKPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:39 INFO - Running setup.py (path:/tmp/pip-Bb1XkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:39 INFO - Running setup.py (path:/tmp/pip-kY_pfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:39 INFO - Running setup.py (path:/tmp/pip-0tyGyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:39 INFO - Running setup.py (path:/tmp/pip-bAv5WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:39 INFO - Running setup.py (path:/tmp/pip-qdaw6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:39 INFO - Running setup.py (path:/tmp/pip-MsoGcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:39 INFO - Running setup.py install for manifestparser 04:13:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Running setup.py install for mozcrash 04:13:40 INFO - Running setup.py install for mozdebug 04:13:40 INFO - Running setup.py install for mozdevice 04:13:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Running setup.py install for mozfile 04:13:40 INFO - Running setup.py install for mozhttpd 04:13:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Running setup.py install for mozinfo 04:13:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Running setup.py install for mozInstall 04:13:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Running setup.py install for mozleak 04:13:40 INFO - Running setup.py install for mozlog 04:13:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Running setup.py install for moznetwork 04:13:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Running setup.py install for mozprocess 04:13:41 INFO - Running setup.py install for mozprofile 04:13:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:41 INFO - Running setup.py install for mozrunner 04:13:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:41 INFO - Running setup.py install for mozscreenshot 04:13:41 INFO - Running setup.py install for moztest 04:13:41 INFO - Running setup.py install for mozversion 04:13:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:41 INFO - Cleaning up... 04:13:41 INFO - Return code: 0 04:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13: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 04:13: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 04:13:41 INFO - Using env: {'DISPLAY': ':0', 04:13:41 INFO - 'HOME': '/home/cltbld', 04:13:41 INFO - 'LANG': 'en_US.UTF-8', 04:13:41 INFO - 'LANGUAGE': 'en_US:en', 04:13:41 INFO - 'LOGNAME': 'cltbld', 04:13:41 INFO - 'MAIL': '/var/mail/cltbld', 04:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:41 INFO - 'MOZ_NO_REMOTE': '1', 04:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:41 INFO - 'NO_EM_RESTART': '1', 04:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:41 INFO - 'PWD': '/builds/slave/test', 04:13:41 INFO - 'SHELL': '/bin/bash', 04:13:41 INFO - 'SHLVL': '1', 04:13:41 INFO - 'TERM': 'linux', 04:13:41 INFO - 'TMOUT': '86400', 04:13:41 INFO - 'USER': 'cltbld', 04:13:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:41 INFO - '_': '/tools/buildbot/bin/python'} 04:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:41 INFO - Running setup.py (path:/tmp/pip-VKPhC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13: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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:41 INFO - Running setup.py (path:/tmp/pip-HabkkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13: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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:41 INFO - Running setup.py (path:/tmp/pip-LQX5EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:42 INFO - Running setup.py (path:/tmp/pip-So5Dqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:42 INFO - Running setup.py (path:/tmp/pip-uPR5UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:42 INFO - Running setup.py (path:/tmp/pip-iEnByi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:42 INFO - Running setup.py (path:/tmp/pip-5QsIwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:42 INFO - Running setup.py (path:/tmp/pip-DYi0UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:42 INFO - Running setup.py (path:/tmp/pip-bjk_rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:42 INFO - Running setup.py (path:/tmp/pip-VI9BRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:42 INFO - Running setup.py (path:/tmp/pip-6ve6Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13: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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:42 INFO - Running setup.py (path:/tmp/pip-1ut5Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13: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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:42 INFO - Running setup.py (path:/tmp/pip-UJ7JpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13: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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:42 INFO - Running setup.py (path:/tmp/pip-5noBmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13: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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:42 INFO - Running setup.py (path:/tmp/pip-PrahxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13: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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:42 INFO - Running setup.py (path:/tmp/pip-SqBbkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:43 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)) 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:43 INFO - Running setup.py (path:/tmp/pip-lhhuG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 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)) 04:13:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:43 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 04:13:43 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 04:13:43 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 04:13:43 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 04:13:43 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 04:13:43 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 04:13:44 INFO - Downloading blessings-1.6.tar.gz 04:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:45 INFO - Installing collected packages: blessings 04:13:45 INFO - Running setup.py install for blessings 04:13:45 INFO - Successfully installed blessings 04:13:45 INFO - Cleaning up... 04:13:45 INFO - Return code: 0 04:13:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:45 INFO - Reading from file tmpfile_stdout 04:13:45 INFO - Current package versions: 04:13:45 INFO - argparse == 1.2.1 04:13:45 INFO - blessings == 1.6 04:13:45 INFO - blobuploader == 1.2.4 04:13:45 INFO - docopt == 0.6.1 04:13:45 INFO - functools32 == 3.2.3-2 04:13:45 INFO - jsonschema == 2.5.1 04:13:45 INFO - manifestparser == 1.1 04:13:45 INFO - mozInstall == 1.12 04:13:45 INFO - mozcrash == 0.17 04:13:45 INFO - mozdebug == 0.1 04:13:45 INFO - mozdevice == 0.48 04:13:45 INFO - mozfile == 1.2 04:13:45 INFO - mozhttpd == 0.7 04:13:45 INFO - mozinfo == 0.9 04:13:45 INFO - mozleak == 0.1 04:13:45 INFO - mozlog == 3.2 04:13:45 INFO - moznetwork == 0.27 04:13:45 INFO - mozprocess == 0.23 04:13:45 INFO - mozprofile == 0.28 04:13:45 INFO - mozrunner == 6.12 04:13:45 INFO - mozscreenshot == 0.1 04:13:45 INFO - mozsystemmonitor == 0.3 04:13:45 INFO - moztest == 0.7 04:13:45 INFO - mozversion == 1.4 04:13:45 INFO - psutil == 3.1.1 04:13:45 INFO - requests == 1.2.3 04:13:45 INFO - wsgiref == 0.1.2 04:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13:45 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 04:13:45 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 04:13:45 INFO - Using env: {'DISPLAY': ':0', 04:13:45 INFO - 'HOME': '/home/cltbld', 04:13:45 INFO - 'LANG': 'en_US.UTF-8', 04:13:45 INFO - 'LANGUAGE': 'en_US:en', 04:13:45 INFO - 'LOGNAME': 'cltbld', 04:13:45 INFO - 'MAIL': '/var/mail/cltbld', 04:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:45 INFO - 'MOZ_NO_REMOTE': '1', 04:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:45 INFO - 'NO_EM_RESTART': '1', 04:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:45 INFO - 'PWD': '/builds/slave/test', 04:13:45 INFO - 'SHELL': '/bin/bash', 04:13:45 INFO - 'SHLVL': '1', 04:13:45 INFO - 'TERM': 'linux', 04:13:45 INFO - 'TMOUT': '86400', 04:13:45 INFO - 'USER': 'cltbld', 04:13:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:45 INFO - '_': '/tools/buildbot/bin/python'} 04:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13:45 INFO - Cleaning up... 04:13:45 INFO - Return code: 0 04:13:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13: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 04:13: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 04:13:45 INFO - Using env: {'DISPLAY': ':0', 04:13:45 INFO - 'HOME': '/home/cltbld', 04:13:45 INFO - 'LANG': 'en_US.UTF-8', 04:13:45 INFO - 'LANGUAGE': 'en_US:en', 04:13:45 INFO - 'LOGNAME': 'cltbld', 04:13:45 INFO - 'MAIL': '/var/mail/cltbld', 04:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:45 INFO - 'MOZ_NO_REMOTE': '1', 04:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:45 INFO - 'NO_EM_RESTART': '1', 04:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:45 INFO - 'PWD': '/builds/slave/test', 04:13:45 INFO - 'SHELL': '/bin/bash', 04:13:45 INFO - 'SHLVL': '1', 04:13:45 INFO - 'TERM': 'linux', 04:13:45 INFO - 'TMOUT': '86400', 04:13:45 INFO - 'USER': 'cltbld', 04:13:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:45 INFO - '_': '/tools/buildbot/bin/python'} 04:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:45 INFO - Cleaning up... 04:13:45 INFO - Return code: 0 04:13:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa22138ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', '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 04:13: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', 'flake8'] in /builds/slave/test/build 04:13: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 flake8 04:13:45 INFO - Using env: {'DISPLAY': ':0', 04:13:45 INFO - 'HOME': '/home/cltbld', 04:13:45 INFO - 'LANG': 'en_US.UTF-8', 04:13:45 INFO - 'LANGUAGE': 'en_US:en', 04:13:45 INFO - 'LOGNAME': 'cltbld', 04:13:45 INFO - 'MAIL': '/var/mail/cltbld', 04:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:45 INFO - 'MOZ_NO_REMOTE': '1', 04:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:45 INFO - 'NO_EM_RESTART': '1', 04:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:45 INFO - 'PWD': '/builds/slave/test', 04:13:45 INFO - 'SHELL': '/bin/bash', 04:13:45 INFO - 'SHLVL': '1', 04:13:45 INFO - 'TERM': 'linux', 04:13:45 INFO - 'TMOUT': '86400', 04:13:45 INFO - 'USER': 'cltbld', 04:13:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:45 INFO - '_': '/tools/buildbot/bin/python'} 04:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:46 INFO - Downloading/unpacking flake8 04:13:46 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 04:13:46 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 04:13:46 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 04:13:46 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 04:13:46 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 04:13:46 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 04:13:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:47 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 04:13:47 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 04:13:47 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 04:13:47 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 04:13:47 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 04:13:47 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 04:13:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:48 INFO - no previously-included directories found matching 'docs/_build' 04:13:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:48 INFO - Running setup.py install for pep8 04:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:48 INFO - no previously-included directories found matching 'docs/_build' 04:13:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:48 INFO - Cleaning up... 04:13:48 INFO - Return code: 0 04:13:48 INFO - Running post-action listener: _resource_record_post_action 04:13:48 INFO - Running post-action listener: _start_resource_monitoring 04:13:48 INFO - Starting resource monitoring. 04:13:48 INFO - ##### 04:13:48 INFO - ##### Finished create-virtualenv step (success) 04:13:48 INFO - ##### 04:13:48 INFO - ##### 04:13:48 INFO - ##### Running install step. 04:13:48 INFO - ##### 04:13:48 INFO - Running pre-action listener: _resource_record_pre_action 04:13:48 INFO - Running main action method: install 04:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:49 INFO - Reading from file tmpfile_stdout 04:13:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:49 INFO - Reading from file tmpfile_stdout 04:13:49 INFO - Output received: 04:13:49 INFO - Usage: mozinstall [options] installer 04:13:49 INFO - Options: 04:13:49 INFO - -h, --help show this help message and exit 04:13:49 INFO - -d DEST, --destination=DEST 04:13:49 INFO - Directory to install application into. [default: 04:13:49 INFO - "/builds/slave/test"] 04:13:49 INFO - --app=APP Application being installed. [default: firefox] 04:13:49 INFO - mkdir: /builds/slave/test/build/application 04:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:02 INFO - Reading from file tmpfile_stdout 04:14:02 INFO - Output received: 04:14:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:02 INFO - Running post-action listener: _resource_record_post_action 04:14:02 INFO - ##### 04:14:02 INFO - ##### Finished install step (success) 04:14:02 INFO - ##### 04:14:02 INFO - ##### 04:14:02 INFO - ##### Running run-tests step. 04:14:02 INFO - ##### 04:14:02 INFO - Running pre-action listener: _resource_record_pre_action 04:14:02 INFO - Running main action method: run_tests 04:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:02 INFO - Python 2.7.3 04:14:02 INFO - Return code: 0 04:14:02 INFO - grabbing minidump binary from tooltool 04:14:02 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')]} 04:14:02 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 0x27302e0>, '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 0x269c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:02 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 04:14:02 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 04:14:02 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 04:14:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:02 INFO - Return code: 0 04:14:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:03 INFO - Return code: 0 04:14:03 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/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 04:14:03 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/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 04:14:03 INFO - Using env: {'DISPLAY': ':0', 04:14:03 INFO - 'HOME': '/home/cltbld', 04:14:03 INFO - 'LANG': 'en_US.UTF-8', 04:14:03 INFO - 'LANGUAGE': 'en_US:en', 04:14:03 INFO - 'LOGNAME': 'cltbld', 04:14:03 INFO - 'MAIL': '/var/mail/cltbld', 04:14:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:03 INFO - 'MOZ_NO_REMOTE': '1', 04:14:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:03 INFO - 'NO_EM_RESTART': '1', 04:14:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:03 INFO - 'PWD': '/builds/slave/test', 04:14:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:03 INFO - 'SHELL': '/bin/bash', 04:14:03 INFO - 'SHLVL': '1', 04:14:03 INFO - 'TERM': 'linux', 04:14:03 INFO - 'TMOUT': '86400', 04:14:03 INFO - 'USER': 'cltbld', 04:14:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416', 04:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:03 INFO - '_': '/tools/buildbot/bin/python'} 04:14:03 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/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 04:14:03 INFO - mozversion application_buildid: 20160826110814 04:14:03 INFO - mozversion application_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:03 INFO - mozversion application_display_name: Firefox 04:14:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:03 INFO - mozversion application_name: Firefox 04:14:03 INFO - mozversion application_remotingname: firefox 04:14:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:03 INFO - mozversion application_vendor: Mozilla 04:14:03 INFO - mozversion application_version: 49.0 04:14:03 INFO - mozversion platform_buildid: 20160826110814 04:14:03 INFO - mozversion platform_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:03 INFO - mozversion platform_version: 49.0 04:14:03 INFO - using testdate: 1472382843 04:14:03 INFO - actual date: 1472382843 04:14:03 INFO - starting webserver on 'localhost:40315' 04:14:03 INFO - SUITE-START | Running 2 tests 04:14:03 INFO - TEST-START | dromaeo_css 04:14:03 INFO - operating with platform_type : linux_ 04:14:03 INFO - Initialising browser for dromaeo_css test... 04:14:03 INFO - TEST-INFO | started process 16581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdO3Vi1/profile http://localhost:40315/getInfo.html) 04:14:07 INFO - PROCESS | 16581 | __metrics Screen width/height:1600/1200 04:14:07 INFO - PROCESS | 16581 | colorDepth:24 04:14:07 INFO - PROCESS | 16581 | Browser inner width/height: 1024/697 04:14:07 INFO - PROCESS | 16581 | __metrics 04:14:08 ERROR - PROCESS | 16581 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:14:09 INFO - TEST-INFO | 16581: exit 0 04:14:09 INFO - Browser initialized. 04:14:09 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:09 INFO - TEST-INFO | started process 16710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdO3Vi1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:21 INFO - PROCESS | 16710 | RSS: Main: 153030656 04:14:21 INFO - PROCESS | 16710 | 04:15:10 INFO - PROCESS | 16710 | 1472382910586 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] 04:17:18 INFO - PROCESS | 16710 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40315/tests/dromaeo/cssquery-ext.html) 04:17:19 INFO - PROCESS | 16710 | RSS: Main: 157655040 04:17:19 INFO - PROCESS | 16710 | 04:20:21 INFO - PROCESS | 16710 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-ext.html (next: http://localhost:40315/tests/dromaeo/cssquery-jquery.html) 04:20:22 INFO - PROCESS | 16710 | RSS: Main: 155893760 04:20:22 INFO - PROCESS | 16710 | 04:23:24 INFO - PROCESS | 16710 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40315/tests/dromaeo/cssquery-mootools.html) 04:23:24 INFO - PROCESS | 16710 | RSS: Main: 155287552 04:23:24 INFO - PROCESS | 16710 | 04:26:26 INFO - PROCESS | 16710 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40315/tests/dromaeo/cssquery-prototype.html) 04:26:26 INFO - PROCESS | 16710 | RSS: Main: 156696576 04:26:26 INFO - PROCESS | 16710 | 04:29:29 INFO - PROCESS | 16710 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40315/tests/dromaeo/cssquery-yui.html) 04:29:29 INFO - PROCESS | 16710 | RSS: Main: 154914816 04:29:29 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | Cycle 1(1): loaded http://localhost:40315/tests/dromaeo/cssquery-yui.html (next: http://localhost:40315/tests/dromaeo/cssquery-dojo.html) 04:32:32 INFO - PROCESS | 16710 | RSS: Main: 159084544 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | __start_tp_report 04:32:32 INFO - PROCESS | 16710 | _x_x_mozilla_page_load 04:32:32 INFO - PROCESS | 16710 | _x_x_mozilla_page_load_details 04:32:32 INFO - PROCESS | 16710 | |i|pagename|runs| 04:32:32 INFO - PROCESS | 16710 | |0;dojo.html;3361.5461912641795;3390.2033022239752;3409.573803274591;3410.386130496511;3420.213350929286;5619.129034999576;5647.689377084259;5650.519705825005;5684.715764211794;5713.085906255;5672.914906276409;5704.229928959589;5752.511036561887;5753.424657534244;5756.251687280647;5057.367829021372;5114.744262786846;5150.562202212797;5153.742312884341;5177.145770947808;5065.721385323805;5087.6184286178495;5175.8188463403785;5178.870528236786;5205.37535495741;5105.540501354877;5112.36095488064;5118.07874582575;5124.052050370675;5189.091908915943;5163.793448262065;5183.999999999981;5184.092783762864;5190.532852043315;5213.218017297436;4869.561739443467;4903.043906438246;5040.672356296829;5096.719680417576;5099.59203263738;5531.502164805147;5563.415841336642;5570.526505247059;5626.6624002559565;5667.971660141673;6046.546509011841;6058.485028772559;6082.2701275847185;6088.452039316483;6092.543059270528;5807.157962095514;5961.463468287831;6026.5178785697035;6166.537509686791;6188.814335569895;5635.887282254332;5637.7181140942785;5640.802571909963;5647.068233741469;5662.037453632893;6179.62922224668;6181.350958149419;6182.381761823782;6187.257529096447;6189.164462797555;5710.771569137188;5783.797567085132;5797.971010144923;5807.68057756819;5909.497692696083;5922.466977972003;5928.79249226275;5939.10913362999;5942.940570594325;6000.189974353494;5931.970340148272;5942.37605051472;5966.582339236212;5971.044632858809;5982.760689572456;5821.359650438449;5914.645121292736;5952.940470595238;5968.432998865101;5992;4609;4622.67641265115;4629;4631.606313463326;4639.721616703008;4038.5961403859965;4106.2198182345255;4116.382542618631;4135.937960930589;4156.168766246702;5701.543876489871;5704.258446401941;5725.227094342211;5812.070068788974;5841.88316233673;6037.516998640098;6145.170401995762;6147.907781383283;6155.169052177988;6159.907601385983;5547.55619550435;5755.22304488897;5854.326752423441;5855.414458554195;5857.355690874;5241.292425522582;5294.152935530296;5320.893582128336;5321.441248668912;5351.545118664879;6325.841853953688;6361.300256971729;6371.713272902731;6375.649339286291;6383.1382763326355;5898.587098903207;5939.07944268639;5982.252218472691;6132.540059495555;6154.169187159676;6267.373262673696;6270.2475702915945;6273.059041143682;6285.340039295808;6286.214223222098;5935.198748168942;5937.554683398849;5938.317093534126;5939.406059394026;5983.640981540947;5936.821895343147;6011.519078473799;6027;6039.849003774941;6078.939210607838;5908.911366329595;5923.170756094064;5943.3759455258305;5944.286685597756;5956.106584012433;5873.530117590497;5964.7912323068485;5969.850753731192;5976.3127240366175;5993.940060599338;5650.067738823048;5773.8556536086935;5825.0679891217205;5883.911476376884;5934.465898069195;5987.191729116687;6025.849353766191;6042.093685947143;6046.818595442144;6066.969665151646;5591.329040515164;5893.499052580579;5897.262842144732;5899.203607513103;5905.645661260338 04:32:32 INFO - PROCESS | 16710 | |1;ext.html;585.8271809816104;633.0851918977079;645.715885010595;658.6739563915861;663.1014974709269;44732.77633611832;46483;46617.76691116548;46662.766686166564;50398.74800626001;48133.51866481334;48649.756751216286;48699.756501217445;48780.26829597559;48836.267455988185;9007.72976810695;9151;9162.450252984809;9170.770730731718;9186.219171370441;8970.372073954826;9053.50205738684;9056.773580660503;9081.318901082412;9098.954505227464;9073.500957447372;9079.137481939206;9096.181343679067;9102.044285350043;9131.406458580204;9061.818763624691;9063.274938004977;9065.864012039825;9073.59168837404;9109.954450227773;8894.911050889474;8954;8961.103889611051;8988.910110898938;9013.954930225373;44030.33954490685;44369.77815110936;44473.55526444726;44503.55496445027;44592;3620.601733809279;3853.325668008087;3876.476675648808;3974.841006359742;4514.706544074625;34051;34570.30859382823;34739.4789078164;34744;34842.303153937035;4087.8569250076403;4104.692148088905;4109.753414795122;4154.584541545852;4159.355299928516;349067;349351;349385;349408;349757;63052.36947630557;63426.68286658629;63479.6826015867;63480;63524;40077;41093.178136437105;41200.58799412027;42204.78897605554;42514;19292.710609340873;19308.517287067654;19594.02029898528;19621;19642.70535941962;14710;14794.038387504777;14838.406463741545;14901.925490372696;14902.254887255594;21024.894875525526;21111.8944405277;21180;21211;21290.78709212888;7658.234176582298;7675.270849269311;7728.18387678895;7731.342835858903;7779.649915753805;1009.137187704502;1116.8268918317674;1128.4470609401335;1173.9647810565696;1184.5498710489958;32853.67146328554;33114.50328245078;33129.17177070544;33200;33464.665353346645;1163.5636636261402;1226.6381417481687;1285.749278890626;1302.4855182203166;1316.2628927800463;17229.138543072797;17427;17453.563660908327;17618;17745.290188392577;511549;596651;830899;875750;891186;58919.70540147358;59495;59536.702316489005;59610;59759.70120149371;1480.9629759256104;1487.9479218227527;1492.4254162147652;1515.5301856424544;1521.8630323270959;31010.689893101684;32056.83971580127;32135.357292853543;32203.51694724534;32556.186095347806;51131;51179.48820511747;51580.74209628928;51630.48369516257;51826.48173518216;336307;336581;340640;341403;341777;30013.3997320048;30085.3982920336;30355.2411189722;30399.69600304057;30534;49478.75260623674;49916.50083499119;50158.49841501538;50538.2419263704;51264;41477;41817.16365672609;42036.159276814906;42362.788186058875;42889.35665965075;40604.98487537835;40638;41864.58135418607;42491;42827.57172428236;41809;42530;42598.78700606601;42945.14109717851;43019.13961720811;36102.4584631236;36908.26183476369;37160.44259336166;37286;37634;28746.425071498034;28897.56653650239;29016.854915725286;29135.562966555095;29237.41525169527 04:32:32 INFO - PROCESS | 16710 | |2;jquery.html;429.2741673100923;430.7544699521274;433.51446380054335;434.9108432771281;448.04119184944204;18379.264829406824;19580.118894649757;20218;20876.478088047807;20963.056662450188;19130.33043843466;19577.804221957776;19649.410517684457;20009.799902000974;20154.697679534784;5842.094475356316;6026.156338112668;6048.546359023091;6057.485113765335;6069.393060693939;5356.839294821161;5738.282714660668;5751.252337196159;5938.703064846762;5989.431004054608;5737.3688894221605;5756.050251708463;5771.624844385102;5788.797392091277;6540.9861471471995;6694.096296999892;6722.630255335979;6729.05793188954;6731.8317042074095;6746.460283177358;5035.924461133086;5348.491893270133;5354.116570765819;5422.53908417785;5932.0508718604815;22990.655140172912;23385.649215261783;23388.532229355318;24267.878660606584;24275.87862060696;2160.7299087614047;2289;2307.8846057697046;2364.8226383021342;2518.3074654469983;10261.486925653762;10589.311694739818;10624.309419887682;11764.35296058725;14804.40782368704;1867.1504465468179;1978.0999645161417;1990;2014.6675798493377;2053.455834203922;80790;84934.57532712359;85839;85886.57056714738;87141.12858871394;10698.946505267424;10824.350538967687;11397.25917815356;11602.477888495037;11928.224665396721;15083.698326033418;15123.092614443169;15132.546023619308;15169.848301516844;15217.239138043053;8409.705660301861;8686.39195256326;8783.516906570072;8803.911960880438;8932.776680582907;8662.566871656392;8735.956320218485;8911;8971.37200395979;9003.954980225188;4436.0906014267;4527.705699129612;4625;4655.4180727409075;4687.273472611751;1940.1560321260297;1948.912298946551;1989.7413336266193;2020.6160829442358;2050.7744148143693;1070.577122036791;1084.6583326252205;1096.0957210301533;1120.882307357732;1132.7338075552238;19643.31248406299;19750.209991600463;19850.205991760457;19851.503712407306;20601.89699051525;1032.2155162076726;1060.1783617696192;1068.5832525315134;1069.0752499088233;1123.915706322029;11050.33697978124;11164.330140191614;11201.21591488588;11288.20982531215;11290.604828831116;395104;395273;399243;497860;551831;90194.09805901989;92367;100674.49662751639;102276.48861755643;106507.46746266219;1062.5484169228048;1103.3049179017169;1109.351029647649;1113.0205419231186;1113.3097479562723;17771.73342399891;17920.731189032434;18056.097195140454;18056.916585004943;18322.541936451697;42875;42912.78543607262;43374;43860.78069609631;45308.54691453043;60141.39858601533;60187.69906150441;60609.39390606037;61757;61835;8914.955425222832;8984.59569319369;9011.23404510624;9142.3600347975;9157.358984870994;10590.205734569783;13259.403326850508;13263;13691.246981416118;13843.930780346034;11867.821982670439;12020.519179232733;12032.639020829389;12049;12151.75696486083;9584.76038099053;11906.52373905034;11943.343116128697;12076.818847717466;12104.51581936748;11927.284362938251;12040.096992725405;12105.273683579013;12196.573119941115;12505.124641275024;8850.645974160961;8986.59560319774;9079.68221112258;9192.17270445663;9268.675596354095;8958.596863141305;11487.712807179887;12306.384680766105;12415.93792031034;12472.189307694971 04:32:32 INFO - PROCESS | 16710 | |3;mootools.html;1566.2168915542231;1573.402107199264;1783.0817129178474;1901.401058666519;1905.1902941249966;9550.474723890184;9659.710208693732;10085.64700235492;10205.693829185127;10241;10154.898451015506;10282.897171028288;10317.484125793699;10327.07056364927;10390.480475976208;2575.459153577751;2626.9474610507777;2629.7764690001277;2631.2369412870244;2634.894604215829;2518.4837108392735;2583.19920824545;2595.338188761863;2598.0646967091834;2608.4783043391303;2588.4564241509306;2589.9223023309237;2623.2261482862505;2624.3307956471167;2636.2486691292984;2449.0326321103244;2457.2382561405934;2463.0640356664444;2478.962815557768;2492.9750702492925;2469.0370755405406;2472.5425796227755;2473.2332976777257;2476.8018558515455;2484.5900426429616;10033.799324013551;10052.095311422006;10072;10094.394336339843;10117.696469105938;5588.30146231721;5635.774569017234;5639.295088113986;5658.264425624684;5682.488576028136;3547.219611685425;3622.0582648511313;3724.050367156358;3725.832337544817;3742.251549690073;1144.1418935798151;1165.2833507392977;1183.4556104192081;1201.5614300780153;1238.2261086820738;12807.551735689207;12818.038647101504;12858.421371038326;12863.228206307558;12875.227486350755;4816.277558366273;5112.437631860493;5250.97374513125;5289.047971365114;5328.733563321818;11041.779164416826;11148;11148.498317575728;11165.720856978478;11219.439028048564;5784.479396854304;5834.241548598655;5848.5321174305955;5858.384869588632;5891.764329426775;5272.92090618641;5474.042042642522;5482.890342193134;5526.557875369961;5601.215829783833;4296.892577685583;4301.698881078294;4319;4369.71596846204;4448.332750087448;1240.1133189769357;1262.5959692898184;1270.9428075736614;1295.0287284536598;1306.137948953686;838.3419016072354;968.7626531499827;989.1839232633107;989.4113002763344;998.1066945084109;6135.938640613536;6145.354737752561;6151.046587778812;6159.19930409044;6276.215473065867;501.9924701129486;507.0847120946653;509.58214264302916;510.91569890968316;516.3829224077267;3944.934867585793;4040.696947728932;4098.5286692030795;4112.383142528584;4112.712110152261;12239.020878329713;12604.495820167274;12608.684782880502;12616;12624.053196010153;11736.119791015708;12318.938405308096;12418.75162496745;12526.373681315898;12537.498500059895;9355.48544830041;9517.809643807224;9526.333156678966;9562.235021198287;9585.520723963775;6286.308506064238;6372.968135159294;6416.550841441054;6472.805815825344;6764.492663050192;10831.566737330419;11546.884531154581;11556.017738491986;11638.592649257236;11674;11563.190576659554;11760.059195264188;11778.76442471163;11810.350430726392;11924.284542927453;8587.141285871363;8761.780955476164;8860;8875.600597972978;8999.10008999121;9851.753706157404;9952.452615106238;9958.402495850272;9969.551370188505;9997.450140242356;8552.102029287083;8734.432261902955;8951.28389728807;9120.270378369847;9133.634654614007;8432.45189062709;8476.618552165291;8598.484090954313;8709.695160669346;8729.388942773945;7466.8506629866015;7496.7376141834775;7504.587247701429;7528.247175282428;7545.245475452411;4855.174620314484;4916.820702402929;4924.778384972757;4933.6299777516115;5055.418626857959;5132.563732082815;5275.2087186920735;5357.973210133924;5382.569394448513;5433.212184233185 04:32:32 INFO - PROCESS | 16710 | |4;prototype.html;348.2304107921493;349.2613123244338;350.05659746981877;350.38507419478816;353.1418652674004;5745.798897038604;5800.53595712343;5840.123981402791;5872.207252020976;5872.9119063213975;5591.3569939456975;5656.490915817586;5683.971580142103;5712.22884910537;5727.455891690293;4037.9394309085314;4357.324614684729;4386.188555117314;4389.4513185851765;4404.779761011952;4372.868813935571;4408.228560002003;4415.763586195854;4448.510663826976;4455.242608756503;4423.314386270134;4428.557144285578;4429.933550996738;4430.446194225722;4431.689781715281;4279.358096285567;4318.188613057213;4359.10638319147;4386.078923426085;4389.341598760196;3783.9054023649355;3807.3527500325013;3811.6188381161937;3822.827972741233;3834.7699138051526;5504.91742623861;5505.311836020497;5519.779208831642;5536.889262214733;5551.1673249012565;4885.755712214375;5040;5041.72270525121;5060.418051924003;5079.111155547765;6007.768407476457;6013.398660133996;6042.818715438544;6067.878642427127;6070.453659170696;4186.518550366716;4197.454330936989;4206.074663574009;4207.64235040022;4212.157568486285;5995.451932928531;6068.180795592627;6195.2518726170465;6233.189685340922;6275.309715931244;4318.762468064287;4346.847860324873;4351.455233392164;4363.52001279859;4370.125974805052;4389.4513185851765;4417.271150260235;4421.712588681726;4421.734695918255;4431.778411079497;4884.389451318585;5012.899742005139;5087.8982420351385;5088.262201980692;5092.439831618519;5975.7609695612555;5988.191594134823;6002.849928751729;6017.909731354033;6036.456718895321;1493.133982290269;1515.886308526865;1524.1921781455846;1528.6942611477748;1528.7324718174275;914.5472990869562;939.7595174369903;955.5843208204453;955.6273053509137;958.9280803939732;5257.316548848702;5264.499872512105;5270.525652691276;5276.15581506957;5302.840914772563;5497.257870187554;5519.702869825588;5528.612997090165;5572.498475137176;5576.832695019156;4929.556339929423;5182.792688292426;5215.973920130375;5239.135542635422;5256;2945.3520225550346;2954.7931644784658;2967.866446009935;2975.6577993531023;2993.7455316297924;5646.435356464321;5667.773289068474;5702.973464776297;5724.513416359656;5735.1970724098655;5305.495977882095;5593.272874526286;5593.8321850344555;5615.747291371898;5616;5657.943420565742;5689.288838895138;5707.486326230659;5718.571107166979;5744.482996530249;5156.432792392909;5485.561155107502;5487.560995120461;5506.045353899308;5512.724363781875;5390.541803946709;5409.215663728816;5434.510894019557;5440.483154100354;5942.405759424196;6475.992442342888;6495.935040649722;6519;6525.934740652533;6549.770758023446;4299.344752270461;4314.22343978087;4332.588404101605;4342.522322544581;4357.106793107469;6153.323134455296;6177.4749146323065;6217.689115544295;6236.968815156077;6330.493560515056;6009.939900601113;6016.789412370546;6017.458428741435;6080.787172448943;6084.817455476343;5852.209951656472;6032.54755893301;6052.517133302369;6053.757849685963;6080.209572755513;5935.79467087785;6001.36985616504;6001.409626448907;6006.669633170218;6027.78902738402;6116.938830611637;6120.908186377297;6133.478654314434;6146.231721034871;6159.81520554384;5766.769329226784;6011.27864656244;6023.789167379121;6035.245594300713;6064.211652485325 04:32:32 INFO - PROCESS | 16710 | |5;yui.html;700.2787129256864;787.7636708987302;787.9527228366296;792.476965202966;814.0760237130854;14838;15774.76337854933;16065;16085.115318657468;16114.11372374519;15049.548513544583;15050.774238386406;15082.09507429555;15086.773698394532;15208.923955380234;842.5534466732641;854.5001174313019;865.926396256319;870.2168048756107;871.2420194430854;860.802015536427;861.3195575495382;864.6282098697588;865.4980111535294;867.1025488619281;908.731924082394;919.6183583812709;921.8755468011833;921.9216366608846;922.1930810540777;900.3202582050575;902.8149229407956;907.7095329494564;908.7818923458323;908.9636414543411;661.9635920024397;663.1346093348227;665.1884700665181;665.6339013542581;668.906353110565;15357.46248881295;15393.692126157413;15424.460143895021;15440.073595584188;15531.611709707235;15633.609159770984;15846.286917088644;15986.200689965455;16091.597710057225;16213.2704028319;11812.114091443176;11968.760624787456;12040.578579749754;12103;12244;3573.1424458130123;3612.096975756061;3622.7826330420257;3686.189038411545;3737.1965027519213;63703.36296637021;63799.362006380274;63815.68092159556;64098.35901641017;64717.676411618115;11746.471408786625;11953.701157471132;12208.694782630506;12314.384280785926;12348.691282717824;20350.59298814045;20573.279935202198;20710.68933965992;20750.377488675364;21391.46521336979;8892.421992570462;8970.41692289999;9001.459912405277;9042.412243204171;9130.178283954476;4942.88846014589;4997.075541024849;5010;5059.8988020239385;5082.567981721521;3764.811759412073;3870.43878637596;3873.496445462128;3874.2638898609175;3879.515060617423;654.5974225851068;666.8899631560738;674.3391476353104;678.2335960364757;703.8170075780232;723.4357201382929;725.8620862036196;733.6955163607043;742.3689863615883;751.8684380008053;9320;10256.743581410525;10894.836577451344;11118.722031949266;11234.606788762354;727.396261103283;735.3565630073685;760.9384908053274;763.3092051693227;780.6994307191773;4487;4664.603508701731;4696.788644511005;4723.338732577442;4736.573708366194;72746;72817.63591182115;73590;74350;74522;72844;80445.19554804494;98740.50629746805;99462.50268748609;101387;59758;87775.56112219526;89943;91949;92600.07399925914;9272.72181834546;9364.672236471692;9391.624335026523;9415.764605884908;9472.242220622196;54527;55110.44889551053;55163;56145.71927140338;56281;56805.71597141988;77873.22126778886;79242.72212852324;80243.59878200805;80445;12299.631011069681;12622.368881555702;12648.241105533698;12847.93576032114;12856.678583035498;13519.729605408034;14071.372053327283;14178.645533861736;14231.71536569242;14239.715205696035;12670.493180272686;12736.87263127394;12935.935320323339;12955;12985.220886746825;12597.68505787326;12599.811002835148;13107.344632768514;13229.80155297652;13363.799543007057;12769.425375857923;12822.679433013876;12831.871681283441;12837.486500539873;13161.736765264832;10419.739506512398;10580.523876425425;10714.839277411002;10849.376897267908;10874.401907895142;10010.531126433047;10113.69658910234;10129.442880641636;10208.93019355751;10288.434136122585 04:32:32 INFO - PROCESS | 16710 | __end_tp_report 04:32:32 INFO - PROCESS | 16710 | __start_cc_report 04:32:32 INFO - PROCESS | 16710 | _x_x_mozilla_cycle_collect,315 04:32:32 INFO - PROCESS | 16710 | __end_cc_report 04:32:32 INFO - PROCESS | 16710 | __startTimestamp1472383952305__endTimestamp 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | ------- Summary: start ------- 04:32:32 INFO - PROCESS | 16710 | Number of tests: 6 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | [#0] dojo.html Cycles:165 Average:5619.66 Median:5854.33 stddev:627.81 (10.7%) stddev-sans-first:604.22 04:32:32 INFO - PROCESS | 16710 | Values: 3361.5 3390.2 3409.6 3410.4 3420.2 5619.1 5647.7 5650.5 5684.7 5713.1 5672.9 5704.2 5752.5 5753.4 5756.3 5057.4 5114.7 5150.6 5153.7 5177.1 5065.7 5087.6 5175.8 5178.9 5205.4 5105.5 5112.4 5118.1 5124.1 5189.1 5163.8 5184.0 5184.1 5190.5 5213.2 4869.6 4903.0 5040.7 5096.7 5099.6 5531.5 5563.4 5570.5 5626.7 5668.0 6046.5 6058.5 6082.3 6088.5 6092.5 5807.2 5961.5 6026.5 6166.5 6188.8 5635.9 5637.7 5640.8 5647.1 5662.0 6179.6 6181.4 6182.4 6187.3 6189.2 5710.8 5783.8 5798.0 5807.7 5909.5 5922.5 5928.8 5939.1 5942.9 6000.2 5932.0 5942.4 5966.6 5971.0 5982.8 5821.4 5914.6 5952.9 5968.4 5992.0 4609.0 4622.7 4629.0 4631.6 4639.7 4038.6 4106.2 4116.4 4135.9 4156.2 5701.5 5704.3 5725.2 5812.1 5841.9 6037.5 6145.2 6147.9 6155.2 6159.9 5547.6 5755.2 5854.3 5855.4 5857.4 5241.3 5294.2 5320.9 5321.4 5351.5 6325.8 6361.3 6371.7 6375.6 6383.1 5898.6 5939.1 5982.3 6132.5 6154.2 6267.4 6270.2 6273.1 6285.3 6286.2 5935.2 5937.6 5938.3 5939.4 5983.6 5936.8 6011.5 6027.0 6039.8 6078.9 5908.9 5923.2 5943.4 5944.3 5956.1 5873.5 5964.8 5969.9 5976.3 5993.9 5650.1 5773.9 5825.1 5883.9 5934.5 5987.2 6025.8 6042.1 6046.8 6067.0 5591.3 5893.5 5897.3 5899.2 5905.6 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | [#1] ext.html Cycles:180 Average:63805.42 Median:41813.08 stddev:139747.07 (334.2%) stddev-sans-first:140058.49 04:32:32 INFO - PROCESS | 16710 | Values: 585.8 633.1 645.7 658.7 663.1 44732.8 46483.0 46617.8 46662.8 50398.7 48133.5 48649.8 48699.8 48780.3 48836.3 9007.7 9151.0 9162.5 9170.8 9186.2 8970.4 9053.5 9056.8 9081.3 9099.0 9073.5 9079.1 9096.2 9102.0 9131.4 9061.8 9063.3 9065.9 9073.6 9110.0 8894.9 8954.0 8961.1 8988.9 9014.0 44030.3 44369.8 44473.6 44503.6 44592.0 3620.6 3853.3 3876.5 3974.8 4514.7 34051.0 34570.3 34739.5 34744.0 34842.3 4087.9 4104.7 4109.8 4154.6 4159.4 349067.0 349351.0 349385.0 349408.0 349757.0 63052.4 63426.7 63479.7 63480.0 63524.0 40077.0 41093.2 41200.6 42204.8 42514.0 19292.7 19308.5 19594.0 19621.0 19642.7 14710.0 14794.0 14838.4 14901.9 14902.3 21024.9 21111.9 21180.0 21211.0 21290.8 7658.2 7675.3 7728.2 7731.3 7779.6 1009.1 1116.8 1128.4 1174.0 1184.5 32853.7 33114.5 33129.2 33200.0 33464.7 1163.6 1226.6 1285.7 1302.5 1316.3 17229.1 17427.0 17453.6 17618.0 17745.3 511549.0 596651.0 830899.0 875750.0 891186.0 58919.7 59495.0 59536.7 59610.0 59759.7 1481.0 1487.9 1492.4 1515.5 1521.9 31010.7 32056.8 32135.4 32203.5 32556.2 51131.0 51179.5 51580.7 51630.5 51826.5 336307.0 336581.0 340640.0 341403.0 341777.0 30013.4 30085.4 30355.2 30399.7 30534.0 49478.8 49916.5 50158.5 50538.2 51264.0 41477.0 41817.2 42036.2 42362.8 42889.4 40605.0 40638.0 41864.6 42491.0 42827.6 41809.0 42530.0 42598.8 42945.1 43019.1 36102.5 36908.3 37160.4 37286.0 37634.0 28746.4 28897.6 29016.9 29135.6 29237.4 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | [#2] jquery.html Cycles:180 Average:28516.97 Median:11561.89 stddev:75127.74 (649.8%) stddev-sans-first:75308.89 04:32:32 INFO - PROCESS | 16710 | Values: 429.3 430.8 433.5 434.9 448.0 18379.3 19580.1 20218.0 20876.5 20963.1 19130.3 19577.8 19649.4 20009.8 20154.7 5842.1 6026.2 6048.5 6057.5 6069.4 5356.8 5738.3 5751.3 5938.7 5989.4 5737.4 5756.1 5771.6 5788.8 6541.0 6694.1 6722.6 6729.1 6731.8 6746.5 5035.9 5348.5 5354.1 5422.5 5932.1 22990.7 23385.6 23388.5 24267.9 24275.9 2160.7 2289.0 2307.9 2364.8 2518.3 10261.5 10589.3 10624.3 11764.4 14804.4 1867.2 1978.1 1990.0 2014.7 2053.5 80790.0 84934.6 85839.0 85886.6 87141.1 10698.9 10824.4 11397.3 11602.5 11928.2 15083.7 15123.1 15132.5 15169.8 15217.2 8409.7 8686.4 8783.5 8803.9 8932.8 8662.6 8736.0 8911.0 8971.4 9004.0 4436.1 4527.7 4625.0 4655.4 4687.3 1940.2 1948.9 1989.7 2020.6 2050.8 1070.6 1084.7 1096.1 1120.9 1132.7 19643.3 19750.2 19850.2 19851.5 20601.9 1032.2 1060.2 1068.6 1069.1 1123.9 11050.3 11164.3 11201.2 11288.2 11290.6 395104.0 395273.0 399243.0 497860.0 551831.0 90194.1 92367.0 100674.5 102276.5 106507.5 1062.5 1103.3 1109.4 1113.0 1113.3 17771.7 17920.7 18056.1 18056.9 18322.5 42875.0 42912.8 43374.0 43860.8 45308.5 60141.4 60187.7 60609.4 61757.0 61835.0 8915.0 8984.6 9011.2 9142.4 9157.4 10590.2 13259.4 13263.0 13691.2 13843.9 11867.8 12020.5 12032.6 12049.0 12151.8 9584.8 11906.5 11943.3 12076.8 12104.5 11927.3 12040.1 12105.3 12196.6 12505.1 8850.6 8986.6 9079.7 9192.2 9268.7 8958.6 11487.7 12306.4 12415.9 12472.2 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | [#3] mootools.html Cycles:180 Average:6420.92 Median:4105.46 stddev:3775.71 (92.0%) stddev-sans-first:3768.67 04:32:32 INFO - PROCESS | 16710 | Values: 1566.2 1573.4 1783.1 1901.4 1905.2 9550.5 9659.7 10085.6 10205.7 10241.0 10154.9 10282.9 10317.5 10327.1 10390.5 2575.5 2626.9 2629.8 2631.2 2634.9 2518.5 2583.2 2595.3 2598.1 2608.5 2588.5 2589.9 2623.2 2624.3 2636.2 2449.0 2457.2 2463.1 2479.0 2493.0 2469.0 2472.5 2473.2 2476.8 2484.6 10033.8 10052.1 10072.0 10094.4 10117.7 5588.3 5635.8 5639.3 5658.3 5682.5 3547.2 3622.1 3724.1 3725.8 3742.3 1144.1 1165.3 1183.5 1201.6 1238.2 12807.6 12818.0 12858.4 12863.2 12875.2 4816.3 5112.4 5251.0 5289.0 5328.7 11041.8 11148.0 11148.5 11165.7 11219.4 5784.5 5834.2 5848.5 5858.4 5891.8 5272.9 5474.0 5482.9 5526.6 5601.2 4296.9 4301.7 4319.0 4369.7 4448.3 1240.1 1262.6 1270.9 1295.0 1306.1 838.3 968.8 989.2 989.4 998.1 6135.9 6145.4 6151.0 6159.2 6276.2 502.0 507.1 509.6 510.9 516.4 3944.9 4040.7 4098.5 4112.4 4112.7 12239.0 12604.5 12608.7 12616.0 12624.1 11736.1 12318.9 12418.8 12526.4 12537.5 9355.5 9517.8 9526.3 9562.2 9585.5 6286.3 6373.0 6416.6 6472.8 6764.5 10831.6 11546.9 11556.0 11638.6 11674.0 11563.2 11760.1 11778.8 11810.4 11924.3 8587.1 8761.8 8860.0 8875.6 8999.1 9851.8 9952.5 9958.4 9969.6 9997.5 8552.1 8734.4 8951.3 9120.3 9133.6 8432.5 8476.6 8598.5 8709.7 8729.4 7466.9 7496.7 7504.6 7528.2 7545.2 4855.2 4916.8 4924.8 4933.6 5055.4 5132.6 5275.2 5358.0 5382.6 5433.2 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | [#4] prototype.html Cycles:180 Average:4901.55 Median:5505.68 stddev:1448.02 (26.3%) stddev-sans-first:1411.18 04:32:32 INFO - PROCESS | 16710 | Values: 348.2 349.3 350.1 350.4 353.1 5745.8 5800.5 5840.1 5872.2 5872.9 5591.4 5656.5 5684.0 5712.2 5727.5 4037.9 4357.3 4386.2 4389.5 4404.8 4372.9 4408.2 4415.8 4448.5 4455.2 4423.3 4428.6 4429.9 4430.4 4431.7 4279.4 4318.2 4359.1 4386.1 4389.3 3783.9 3807.4 3811.6 3822.8 3834.8 5504.9 5505.3 5519.8 5536.9 5551.2 4885.8 5040.0 5041.7 5060.4 5079.1 6007.8 6013.4 6042.8 6067.9 6070.5 4186.5 4197.5 4206.1 4207.6 4212.2 5995.5 6068.2 6195.3 6233.2 6275.3 4318.8 4346.8 4351.5 4363.5 4370.1 4389.5 4417.3 4421.7 4421.7 4431.8 4884.4 5012.9 5087.9 5088.3 5092.4 5975.8 5988.2 6002.8 6017.9 6036.5 1493.1 1515.9 1524.2 1528.7 1528.7 914.5 939.8 955.6 955.6 958.9 5257.3 5264.5 5270.5 5276.2 5302.8 5497.3 5519.7 5528.6 5572.5 5576.8 4929.6 5182.8 5216.0 5239.1 5256.0 2945.4 2954.8 2967.9 2975.7 2993.7 5646.4 5667.8 5703.0 5724.5 5735.2 5305.5 5593.3 5593.8 5615.7 5616.0 5657.9 5689.3 5707.5 5718.6 5744.5 5156.4 5485.6 5487.6 5506.0 5512.7 5390.5 5409.2 5434.5 5440.5 5942.4 6476.0 6495.9 6519.0 6525.9 6549.8 4299.3 4314.2 4332.6 4342.5 4357.1 6153.3 6177.5 6217.7 6237.0 6330.5 6009.9 6016.8 6017.5 6080.8 6084.8 5852.2 6032.5 6052.5 6053.8 6080.2 5935.8 6001.4 6001.4 6006.7 6027.8 6116.9 6120.9 6133.5 6146.2 6159.8 5766.8 6011.3 6023.8 6035.2 6064.2 04:32:32 INFO - PROCESS | 16710 | 04:32:32 INFO - PROCESS | 16710 | [#5] yui.html Cycles:180 Average:19158.08 Median:4969.98 stddev:25796.54 (519.0%) stddev-sans-first:25831.67 04:32:32 INFO - PROCESS | 16710 | Values: 700.3 787.8 788.0 792.5 814.1 14838.0 15774.8 16065.0 16085.1 16114.1 15049.5 15050.8 15082.1 15086.8 15208.9 842.6 854.5 865.9 870.2 871.2 860.8 861.3 864.6 865.5 867.1 908.7 919.6 921.9 921.9 922.2 900.3 902.8 907.7 908.8 909.0 662.0 663.1 665.2 665.6 668.9 15357.5 15393.7 15424.5 15440.1 15531.6 15633.6 15846.3 15986.2 16091.6 16213.3 11812.1 11968.8 12040.6 12103.0 12244.0 3573.1 3612.1 3622.8 3686.2 3737.2 63703.4 63799.4 63815.7 64098.4 64717.7 11746.5 11953.7 12208.7 12314.4 12348.7 20350.6 20573.3 20710.7 20750.4 21391.5 8892.4 8970.4 9001.5 9042.4 9130.2 4942.9 4997.1 5010.0 5059.9 5082.6 3764.8 3870.4 3873.5 3874.3 3879.5 654.6 666.9 674.3 678.2 703.8 723.4 725.9 733.7 742.4 751.9 9320.0 10256.7 10894.8 11118.7 11234.6 727.4 735.4 760.9 763.3 780.7 4487.0 4664.6 4696.8 4723.3 4736.6 72746.0 72817.6 73590.0 74350.0 74522.0 72844.0 80445.2 98740.5 99462.5 101387.0 59758.0 87775.6 89943.0 91949.0 92600.1 9272.7 9364.7 9391.6 9415.8 9472.2 54527.0 55110.4 55163.0 56145.7 56281.0 56805.7 77873.2 79242.7 80243.6 80445.0 12299.6 12622.4 12648.2 12847.9 12856.7 13519.7 14071.4 14178.6 14231.7 14239.7 12670.5 12736.9 12935.9 12955.0 12985.2 12597.7 12599.8 13107.3 13229.8 13363.8 12769.4 12822.7 12831.9 12837.5 13161.7 10419.7 10580.5 10714.8 10849.4 10874.4 10010.5 10113.7 10129.4 10208.9 10288.4 04:32:32 INFO - PROCESS | 16710 | -------- Summary: end -------- 04:32:32 INFO - PROCESS | 16710 | 04:32:33 INFO - TEST-INFO | 16710: exit 0 04:32:33 INFO - TEST-OK | dromaeo_css | took 1109437ms 04:32:33 INFO - TEST-START | kraken 04:32:33 INFO - operating with platform_type : linux_ 04:32:33 INFO - Initialising browser for kraken test... 04:32:33 INFO - TEST-INFO | started process 16960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyKBlEg/profile http://localhost:40315/getInfo.html) 04:32:37 INFO - PROCESS | 16960 | __metrics Screen width/height:1600/1200 04:32:37 INFO - PROCESS | 16960 | colorDepth:24 04:32:37 INFO - PROCESS | 16960 | Browser inner width/height: 1024/697 04:32:37 INFO - PROCESS | 16960 | __metrics 04:32:37 ERROR - PROCESS | 16960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:32:38 INFO - TEST-INFO | 16960: exit 0 04:32:38 INFO - Browser initialized. 04:32:38 INFO - Running cycle 1/1 for kraken test... 04:32:38 INFO - TEST-INFO | started process 17088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyKBlEg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:50 INFO - PROCESS | 17088 | RSS: Main: 153284608 04:32:50 INFO - PROCESS | 17088 | 04:32:52 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:53 INFO - PROCESS | 17088 | RSS: Main: 158433280 04:32:53 INFO - PROCESS | 17088 | 04:32:56 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-dft) 04:32:57 INFO - PROCESS | 17088 | RSS: Main: 157634560 04:32:57 INFO - PROCESS | 17088 | 04:32:59 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-fft) 04:33:00 INFO - PROCESS | 17088 | RSS: Main: 158810112 04:33:00 INFO - PROCESS | 17088 | 04:33:02 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40315/tests/kraken/driver.html?testName=audio-oscillator) 04:33:03 INFO - PROCESS | 17088 | RSS: Main: 158081024 04:33:03 INFO - PROCESS | 17088 | 04:33:05 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:05 INFO - PROCESS | 17088 | RSS: Main: 158187520 04:33:05 INFO - PROCESS | 17088 | 04:33:09 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40315/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:09 INFO - PROCESS | 17088 | RSS: Main: 157548544 04:33:09 INFO - PROCESS | 17088 | 04:33:13 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40315/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:13 INFO - PROCESS | 17088 | RSS: Main: 158097408 04:33:13 INFO - PROCESS | 17088 | 04:33:16 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40315/tests/kraken/driver.html?testName=json-parse-financial) 04:33:17 INFO - PROCESS | 17088 | RSS: Main: 157929472 04:33:17 INFO - PROCESS | 17088 | 04:33:18 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:19 INFO - PROCESS | 17088 | RSS: Main: 157663232 04:33:19 INFO - PROCESS | 17088 | 04:33:20 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:21 INFO - PROCESS | 17088 | RSS: Main: 158015488 04:33:21 INFO - PROCESS | 17088 | 04:33:23 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:24 INFO - PROCESS | 17088 | RSS: Main: 158343168 04:33:24 INFO - PROCESS | 17088 | 04:33:26 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:27 INFO - PROCESS | 17088 | RSS: Main: 158998528 04:33:27 INFO - PROCESS | 17088 | 04:33:30 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:30 INFO - PROCESS | 17088 | RSS: Main: 158400512 04:33:30 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | Cycle 1(1): loaded http://localhost:40315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40315/tests/kraken/driver.html?testName=ai-astar) 04:33:32 INFO - PROCESS | 17088 | RSS: Main: 158564352 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | __start_tp_report 04:33:32 INFO - PROCESS | 17088 | _x_x_mozilla_page_load 04:33:32 INFO - PROCESS | 17088 | _x_x_mozilla_page_load_details 04:33:32 INFO - PROCESS | 17088 | |i|pagename|runs| 04:33:32 INFO - PROCESS | 17088 | |0;ai-astar;110;106;111;110;111;111;111;109;111;110 04:33:32 INFO - PROCESS | 17088 | |1;audio-beat-detection;161;123;154;178;133;160;156;129;179;125 04:33:32 INFO - PROCESS | 17088 | |2;audio-dft;166;163;162;165;162;162;163;163;163;166 04:33:32 INFO - PROCESS | 17088 | |3;audio-fft;76;76;77;184;76;76;76;77;179;76 04:33:32 INFO - PROCESS | 17088 | |4;audio-oscillator;85;85;143;85;86;84;134;86;85;140 04:33:32 INFO - PROCESS | 17088 | |5;imaging-gaussian-blur;118;117;117;117;117;118;117;117;117;117 04:33:32 INFO - PROCESS | 17088 | |6;imaging-darkroom;150;148;146;147;146;148;146;146;147;146 04:33:32 INFO - PROCESS | 17088 | |7;imaging-desaturate;96;95;97;95;95;97;96;95;95;95 04:33:32 INFO - PROCESS | 17088 | |8;json-parse-financial;55;54;55;57;57;56;55;54;59;56 04:33:32 INFO - PROCESS | 17088 | |9;json-stringify-tinderbox;62;61;60;61;61;61;62;61;61;62 04:33:32 INFO - PROCESS | 17088 | |10;stanford-crypto-aes;77;77;76;78;77;78;78;81;107;80 04:33:32 INFO - PROCESS | 17088 | |11;stanford-crypto-ccm;121;123;124;131;131;124;127;124;130;133 04:33:32 INFO - PROCESS | 17088 | |12;stanford-crypto-pbkdf2;152;157;154;158;158;157;152;160;155;154 04:33:32 INFO - PROCESS | 17088 | |13;stanford-crypto-sha256-iterative;63;64;63;67;64;61;63;62;61;61 04:33:32 INFO - PROCESS | 17088 | __end_tp_report 04:33:32 INFO - PROCESS | 17088 | __start_cc_report 04:33:32 INFO - PROCESS | 17088 | _x_x_mozilla_cycle_collect,848 04:33:32 INFO - PROCESS | 17088 | __end_cc_report 04:33:32 INFO - PROCESS | 17088 | __startTimestamp1472384012644__endTimestamp 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | ------- Summary: start ------- 04:33:32 INFO - PROCESS | 17088 | Number of tests: 14 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.56 (1.4%) stddev-sans-first:1.66 04:33:32 INFO - PROCESS | 17088 | Values: 110.0 106.0 111.0 110.0 111.0 111.0 111.0 109.0 111.0 110.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:158.00 stddev:21.03 (13.3%) stddev-sans-first:21.92 04:33:32 INFO - PROCESS | 17088 | Values: 161.0 123.0 154.0 178.0 133.0 160.0 156.0 129.0 179.0 125.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:1.58 (1.0%) stddev-sans-first:1.39 04:33:32 INFO - PROCESS | 17088 | Values: 166.0 163.0 162.0 165.0 162.0 162.0 163.0 163.0 163.0 166.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#3] audio-fft Cycles:10 Average:97.30 Median:76.00 stddev:44.39 (58.4%) stddev-sans-first:46.41 04:33:32 INFO - PROCESS | 17088 | Values: 76.0 76.0 77.0 184.0 76.0 76.0 76.0 77.0 179.0 76.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:85.00 stddev:26.11 (30.7%) stddev-sans-first:27.02 04:33:32 INFO - PROCESS | 17088 | Values: 85.0 85.0 143.0 85.0 86.0 84.0 134.0 86.0 85.0 140.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:33:32 INFO - PROCESS | 17088 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.33 (0.9%) stddev-sans-first:0.87 04:33:32 INFO - PROCESS | 17088 | Values: 150.0 148.0 146.0 147.0 146.0 148.0 146.0 146.0 147.0 146.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 04:33:32 INFO - PROCESS | 17088 | Values: 96.0 95.0 97.0 95.0 95.0 97.0 96.0 95.0 95.0 95.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.62 04:33:32 INFO - PROCESS | 17088 | Values: 55.0 54.0 55.0 57.0 57.0 56.0 55.0 54.0 59.0 56.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 04:33:32 INFO - PROCESS | 17088 | Values: 62.0 61.0 60.0 61.0 61.0 61.0 62.0 61.0 61.0 62.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:78.00 stddev:9.29 (11.9%) stddev-sans-first:9.75 04:33:32 INFO - PROCESS | 17088 | Values: 77.0 77.0 76.0 78.0 77.0 78.0 78.0 81.0 107.0 80.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:128.50 stddev:4.16 (3.2%) stddev-sans-first:3.84 04:33:32 INFO - PROCESS | 17088 | Values: 121.0 123.0 124.0 131.0 131.0 124.0 127.0 124.0 130.0 133.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:157.00 stddev:2.71 (1.7%) stddev-sans-first:2.52 04:33:32 INFO - PROCESS | 17088 | Values: 152.0 157.0 154.0 158.0 158.0 157.0 152.0 160.0 155.0 154.0 04:33:32 INFO - PROCESS | 17088 | 04:33:32 INFO - PROCESS | 17088 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.85 (2.9%) stddev-sans-first:1.96 04:33:32 INFO - PROCESS | 17088 | Values: 63.0 64.0 63.0 67.0 64.0 61.0 63.0 62.0 61.0 61.0 04:33:32 INFO - PROCESS | 17088 | -------- Summary: end -------- 04:33:32 INFO - PROCESS | 17088 | 04:33:33 INFO - TEST-INFO | 17088: exit 0 04:33:33 INFO - TEST-OK | kraken | took 60624ms 04:33:33 INFO - SUITE-END | took 1170s 04:33:33 INFO - Completed test suite (00:19:30) 04:33:33 INFO - javascript benchmark 04:33:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7559.729381844413, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3361.5461912641795, 3390.2033022239752, 3409.573803274591, 3410.386130496511, 3420.213350929286, 5619.129034999576, 5647.689377084259, 5650.519705825005, 5684.715764211794, 5713.085906255, 5672.914906276409, 5704.229928959589, 5752.511036561887, 5753.424657534244, 5756.251687280647, 5057.367829021372, 5114.744262786846, 5150.562202212797, 5153.742312884341, 5177.145770947808, 5065.721385323805, 5087.6184286178495, 5175.8188463403785, 5178.870528236786, 5205.37535495741, 5105.540501354877, 5112.36095488064, 5118.07874582575, 5124.052050370675, 5189.091908915943, 5163.793448262065, 5183.999999999981, 5184.092783762864, 5190.532852043315, 5213.218017297436, 4869.561739443467, 4903.043906438246, 5040.672356296829, 5096.719680417576, 5099.59203263738, 5531.502164805147, 5563.415841336642, 5570.526505247059, 5626.6624002559565, 5667.971660141673, 6046.546509011841, 6058.485028772559, 6082.2701275847185, 6088.452039316483, 6092.543059270528, 5807.157962095514, 5961.463468287831, 6026.5178785697035, 6166.537509686791, 6188.814335569895, 5635.887282254332, 5637.7181140942785, 5640.802571909963, 5647.068233741469, 5662.037453632893, 6179.62922224668, 6181.350958149419, 6182.381761823782, 6187.257529096447, 6189.164462797555, 5710.771569137188, 5783.797567085132, 5797.971010144923, 5807.68057756819, 5909.497692696083, 5922.466977972003, 5928.79249226275, 5939.10913362999, 5942.940570594325, 6000.189974353494, 5931.970340148272, 5942.37605051472, 5966.582339236212, 5971.044632858809, 5982.760689572456, 5821.359650438449, 5914.645121292736, 5952.940470595238, 5968.432998865101, 5992.0, 4609.0, 4622.67641265115, 4629.0, 4631.606313463326, 4639.721616703008, 4038.5961403859965, 4106.2198182345255, 4116.382542618631, 4135.937960930589, 4156.168766246702, 5701.543876489871, 5704.258446401941, 5725.227094342211, 5812.070068788974, 5841.88316233673, 6037.516998640098, 6145.170401995762, 6147.907781383283, 6155.169052177988, 6159.907601385983, 5547.55619550435, 5755.22304488897, 5854.326752423441, 5855.414458554195, 5857.355690874, 5241.292425522582, 5294.152935530296, 5320.893582128336, 5321.441248668912, 5351.545118664879, 6325.841853953688, 6361.300256971729, 6371.713272902731, 6375.649339286291, 6383.1382763326355, 5898.587098903207, 5939.07944268639, 5982.252218472691, 6132.540059495555, 6154.169187159676, 6267.373262673696, 6270.2475702915945, 6273.059041143682, 6285.340039295808, 6286.214223222098, 5935.198748168942, 5937.554683398849, 5938.317093534126, 5939.406059394026, 5983.640981540947, 5936.821895343147, 6011.519078473799, 6027.0, 6039.849003774941, 6078.939210607838, 5908.911366329595, 5923.170756094064, 5943.3759455258305, 5944.286685597756, 5956.106584012433, 5873.530117590497, 5964.7912323068485, 5969.850753731192, 5976.3127240366175, 5993.940060599338, 5650.067738823048, 5773.8556536086935, 5825.0679891217205, 5883.911476376884, 5934.465898069195, 5987.191729116687, 6025.849353766191, 6042.093685947143, 6046.818595442144, 6066.969665151646, 5591.329040515164, 5893.499052580579, 5897.262842144732, 5899.203607513103, 5905.645661260338], "value": 5578.733942119882, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8271809816104, 633.0851918977079, 645.715885010595, 658.6739563915861, 663.1014974709269, 44732.77633611832, 46483.0, 46617.76691116548, 46662.766686166564, 50398.74800626001, 48133.51866481334, 48649.756751216286, 48699.756501217445, 48780.26829597559, 48836.267455988185, 9007.72976810695, 9151.0, 9162.450252984809, 9170.770730731718, 9186.219171370441, 8970.372073954826, 9053.50205738684, 9056.773580660503, 9081.318901082412, 9098.954505227464, 9073.500957447372, 9079.137481939206, 9096.181343679067, 9102.044285350043, 9131.406458580204, 9061.818763624691, 9063.274938004977, 9065.864012039825, 9073.59168837404, 9109.954450227773, 8894.911050889474, 8954.0, 8961.103889611051, 8988.910110898938, 9013.954930225373, 44030.33954490685, 44369.77815110936, 44473.55526444726, 44503.55496445027, 44592.0, 3620.601733809279, 3853.325668008087, 3876.476675648808, 3974.841006359742, 4514.706544074625, 34051.0, 34570.30859382823, 34739.4789078164, 34744.0, 34842.303153937035, 4087.8569250076403, 4104.692148088905, 4109.753414795122, 4154.584541545852, 4159.355299928516, 349067.0, 349351.0, 349385.0, 349408.0, 349757.0, 63052.36947630557, 63426.68286658629, 63479.6826015867, 63480.0, 63524.0, 40077.0, 41093.178136437105, 41200.58799412027, 42204.78897605554, 42514.0, 19292.710609340873, 19308.517287067654, 19594.02029898528, 19621.0, 19642.70535941962, 14710.0, 14794.038387504777, 14838.406463741545, 14901.925490372696, 14902.254887255594, 21024.894875525526, 21111.8944405277, 21180.0, 21211.0, 21290.78709212888, 7658.234176582298, 7675.270849269311, 7728.18387678895, 7731.342835858903, 7779.649915753805, 1009.137187704502, 1116.8268918317674, 1128.4470609401335, 1173.9647810565696, 1184.5498710489958, 32853.67146328554, 33114.50328245078, 33129.17177070544, 33200.0, 33464.665353346645, 1163.5636636261402, 1226.6381417481687, 1285.749278890626, 1302.4855182203166, 1316.2628927800463, 17229.138543072797, 17427.0, 17453.563660908327, 17618.0, 17745.290188392577, 511549.0, 596651.0, 830899.0, 875750.0, 891186.0, 58919.70540147358, 59495.0, 59536.702316489005, 59610.0, 59759.70120149371, 1480.9629759256104, 1487.9479218227527, 1492.4254162147652, 1515.5301856424544, 1521.8630323270959, 31010.689893101684, 32056.83971580127, 32135.357292853543, 32203.51694724534, 32556.186095347806, 51131.0, 51179.48820511747, 51580.74209628928, 51630.48369516257, 51826.48173518216, 336307.0, 336581.0, 340640.0, 341403.0, 341777.0, 30013.3997320048, 30085.3982920336, 30355.2411189722, 30399.69600304057, 30534.0, 49478.75260623674, 49916.50083499119, 50158.49841501538, 50538.2419263704, 51264.0, 41477.0, 41817.16365672609, 42036.159276814906, 42362.788186058875, 42889.35665965075, 40604.98487537835, 40638.0, 41864.58135418607, 42491.0, 42827.57172428236, 41809.0, 42530.0, 42598.78700606601, 42945.14109717851, 43019.13961720811, 36102.4584631236, 36908.26183476369, 37160.44259336166, 37286.0, 37634.0, 28746.425071498034, 28897.56653650239, 29016.854915725286, 29135.562966555095, 29237.41525169527], "value": 20941.150059650812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.2741673100923, 430.7544699521274, 433.51446380054335, 434.9108432771281, 448.04119184944204, 18379.264829406824, 19580.118894649757, 20218.0, 20876.478088047807, 20963.056662450188, 19130.33043843466, 19577.804221957776, 19649.410517684457, 20009.799902000974, 20154.697679534784, 5842.094475356316, 6026.156338112668, 6048.546359023091, 6057.485113765335, 6069.393060693939, 5356.839294821161, 5738.282714660668, 5751.252337196159, 5938.703064846762, 5989.431004054608, 5737.3688894221605, 5756.050251708463, 5771.624844385102, 5788.797392091277, 6540.9861471471995, 6694.096296999892, 6722.630255335979, 6729.05793188954, 6731.8317042074095, 6746.460283177358, 5035.924461133086, 5348.491893270133, 5354.116570765819, 5422.53908417785, 5932.0508718604815, 22990.655140172912, 23385.649215261783, 23388.532229355318, 24267.878660606584, 24275.87862060696, 2160.7299087614047, 2289.0, 2307.8846057697046, 2364.8226383021342, 2518.3074654469983, 10261.486925653762, 10589.311694739818, 10624.309419887682, 11764.35296058725, 14804.40782368704, 1867.1504465468179, 1978.0999645161417, 1990.0, 2014.6675798493377, 2053.455834203922, 80790.0, 84934.57532712359, 85839.0, 85886.57056714738, 87141.12858871394, 10698.946505267424, 10824.350538967687, 11397.25917815356, 11602.477888495037, 11928.224665396721, 15083.698326033418, 15123.092614443169, 15132.546023619308, 15169.848301516844, 15217.239138043053, 8409.705660301861, 8686.39195256326, 8783.516906570072, 8803.911960880438, 8932.776680582907, 8662.566871656392, 8735.956320218485, 8911.0, 8971.37200395979, 9003.954980225188, 4436.0906014267, 4527.705699129612, 4625.0, 4655.4180727409075, 4687.273472611751, 1940.1560321260297, 1948.912298946551, 1989.7413336266193, 2020.6160829442358, 2050.7744148143693, 1070.577122036791, 1084.6583326252205, 1096.0957210301533, 1120.882307357732, 1132.7338075552238, 19643.31248406299, 19750.209991600463, 19850.205991760457, 19851.503712407306, 20601.89699051525, 1032.2155162076726, 1060.1783617696192, 1068.5832525315134, 1069.0752499088233, 1123.915706322029, 11050.33697978124, 11164.330140191614, 11201.21591488588, 11288.20982531215, 11290.604828831116, 395104.0, 395273.0, 399243.0, 497860.0, 551831.0, 90194.09805901989, 92367.0, 100674.49662751639, 102276.48861755643, 106507.46746266219, 1062.5484169228048, 1103.3049179017169, 1109.351029647649, 1113.0205419231186, 1113.3097479562723, 17771.73342399891, 17920.731189032434, 18056.097195140454, 18056.916585004943, 18322.541936451697, 42875.0, 42912.78543607262, 43374.0, 43860.78069609631, 45308.54691453043, 60141.39858601533, 60187.69906150441, 60609.39390606037, 61757.0, 61835.0, 8914.955425222832, 8984.59569319369, 9011.23404510624, 9142.3600347975, 9157.358984870994, 10590.205734569783, 13259.403326850508, 13263.0, 13691.246981416118, 13843.930780346034, 11867.821982670439, 12020.519179232733, 12032.639020829389, 12049.0, 12151.75696486083, 9584.76038099053, 11906.52373905034, 11943.343116128697, 12076.818847717466, 12104.51581936748, 11927.284362938251, 12040.096992725405, 12105.273683579013, 12196.573119941115, 12505.124641275024, 8850.645974160961, 8986.59560319774, 9079.68221112258, 9192.17270445663, 9268.675596354095, 8958.596863141305, 11487.712807179887, 12306.384680766105, 12415.93792031034, 12472.189307694971], "value": 9576.18486338484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.2168915542231, 1573.402107199264, 1783.0817129178474, 1901.401058666519, 1905.1902941249966, 9550.474723890184, 9659.710208693732, 10085.64700235492, 10205.693829185127, 10241.0, 10154.898451015506, 10282.897171028288, 10317.484125793699, 10327.07056364927, 10390.480475976208, 2575.459153577751, 2626.9474610507777, 2629.7764690001277, 2631.2369412870244, 2634.894604215829, 2518.4837108392735, 2583.19920824545, 2595.338188761863, 2598.0646967091834, 2608.4783043391303, 2588.4564241509306, 2589.9223023309237, 2623.2261482862505, 2624.3307956471167, 2636.2486691292984, 2449.0326321103244, 2457.2382561405934, 2463.0640356664444, 2478.962815557768, 2492.9750702492925, 2469.0370755405406, 2472.5425796227755, 2473.2332976777257, 2476.8018558515455, 2484.5900426429616, 10033.799324013551, 10052.095311422006, 10072.0, 10094.394336339843, 10117.696469105938, 5588.30146231721, 5635.774569017234, 5639.295088113986, 5658.264425624684, 5682.488576028136, 3547.219611685425, 3622.0582648511313, 3724.050367156358, 3725.832337544817, 3742.251549690073, 1144.1418935798151, 1165.2833507392977, 1183.4556104192081, 1201.5614300780153, 1238.2261086820738, 12807.551735689207, 12818.038647101504, 12858.421371038326, 12863.228206307558, 12875.227486350755, 4816.277558366273, 5112.437631860493, 5250.97374513125, 5289.047971365114, 5328.733563321818, 11041.779164416826, 11148.0, 11148.498317575728, 11165.720856978478, 11219.439028048564, 5784.479396854304, 5834.241548598655, 5848.5321174305955, 5858.384869588632, 5891.764329426775, 5272.92090618641, 5474.042042642522, 5482.890342193134, 5526.557875369961, 5601.215829783833, 4296.892577685583, 4301.698881078294, 4319.0, 4369.71596846204, 4448.332750087448, 1240.1133189769357, 1262.5959692898184, 1270.9428075736614, 1295.0287284536598, 1306.137948953686, 838.3419016072354, 968.7626531499827, 989.1839232633107, 989.4113002763344, 998.1066945084109, 6135.938640613536, 6145.354737752561, 6151.046587778812, 6159.19930409044, 6276.215473065867, 501.9924701129486, 507.0847120946653, 509.58214264302916, 510.91569890968316, 516.3829224077267, 3944.934867585793, 4040.696947728932, 4098.5286692030795, 4112.383142528584, 4112.712110152261, 12239.020878329713, 12604.495820167274, 12608.684782880502, 12616.0, 12624.053196010153, 11736.119791015708, 12318.938405308096, 12418.75162496745, 12526.373681315898, 12537.498500059895, 9355.48544830041, 9517.809643807224, 9526.333156678966, 9562.235021198287, 9585.520723963775, 6286.308506064238, 6372.968135159294, 6416.550841441054, 6472.805815825344, 6764.492663050192, 10831.566737330419, 11546.884531154581, 11556.017738491986, 11638.592649257236, 11674.0, 11563.190576659554, 11760.059195264188, 11778.76442471163, 11810.350430726392, 11924.284542927453, 8587.141285871363, 8761.780955476164, 8860.0, 8875.600597972978, 8999.10008999121, 9851.753706157404, 9952.452615106238, 9958.402495850272, 9969.551370188505, 9997.450140242356, 8552.102029287083, 8734.432261902955, 8951.28389728807, 9120.270378369847, 9133.634654614007, 8432.45189062709, 8476.618552165291, 8598.484090954313, 8709.695160669346, 8729.388942773945, 7466.8506629866015, 7496.7376141834775, 7504.587247701429, 7528.247175282428, 7545.245475452411, 4855.174620314484, 4916.820702402929, 4924.778384972757, 4933.6299777516115, 5055.418626857959, 5132.563732082815, 5275.2087186920735, 5357.973210133924, 5382.569394448513, 5433.212184233185], "value": 4983.6936969343105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.2304107921493, 349.2613123244338, 350.05659746981877, 350.38507419478816, 353.1418652674004, 5745.798897038604, 5800.53595712343, 5840.123981402791, 5872.207252020976, 5872.9119063213975, 5591.3569939456975, 5656.490915817586, 5683.971580142103, 5712.22884910537, 5727.455891690293, 4037.9394309085314, 4357.324614684729, 4386.188555117314, 4389.4513185851765, 4404.779761011952, 4372.868813935571, 4408.228560002003, 4415.763586195854, 4448.510663826976, 4455.242608756503, 4423.314386270134, 4428.557144285578, 4429.933550996738, 4430.446194225722, 4431.689781715281, 4279.358096285567, 4318.188613057213, 4359.10638319147, 4386.078923426085, 4389.341598760196, 3783.9054023649355, 3807.3527500325013, 3811.6188381161937, 3822.827972741233, 3834.7699138051526, 5504.91742623861, 5505.311836020497, 5519.779208831642, 5536.889262214733, 5551.1673249012565, 4885.755712214375, 5040.0, 5041.72270525121, 5060.418051924003, 5079.111155547765, 6007.768407476457, 6013.398660133996, 6042.818715438544, 6067.878642427127, 6070.453659170696, 4186.518550366716, 4197.454330936989, 4206.074663574009, 4207.64235040022, 4212.157568486285, 5995.451932928531, 6068.180795592627, 6195.2518726170465, 6233.189685340922, 6275.309715931244, 4318.762468064287, 4346.847860324873, 4351.455233392164, 4363.52001279859, 4370.125974805052, 4389.4513185851765, 4417.271150260235, 4421.712588681726, 4421.734695918255, 4431.778411079497, 4884.389451318585, 5012.899742005139, 5087.8982420351385, 5088.262201980692, 5092.439831618519, 5975.7609695612555, 5988.191594134823, 6002.849928751729, 6017.909731354033, 6036.456718895321, 1493.133982290269, 1515.886308526865, 1524.1921781455846, 1528.6942611477748, 1528.7324718174275, 914.5472990869562, 939.7595174369903, 955.5843208204453, 955.6273053509137, 958.9280803939732, 5257.316548848702, 5264.499872512105, 5270.525652691276, 5276.15581506957, 5302.840914772563, 5497.257870187554, 5519.702869825588, 5528.612997090165, 5572.498475137176, 5576.832695019156, 4929.556339929423, 5182.792688292426, 5215.973920130375, 5239.135542635422, 5256.0, 2945.3520225550346, 2954.7931644784658, 2967.866446009935, 2975.6577993531023, 2993.7455316297924, 5646.435356464321, 5667.773289068474, 5702.973464776297, 5724.513416359656, 5735.1970724098655, 5305.495977882095, 5593.272874526286, 5593.8321850344555, 5615.747291371898, 5616.0, 5657.943420565742, 5689.288838895138, 5707.486326230659, 5718.571107166979, 5744.482996530249, 5156.432792392909, 5485.561155107502, 5487.560995120461, 5506.045353899308, 5512.724363781875, 5390.541803946709, 5409.215663728816, 5434.510894019557, 5440.483154100354, 5942.405759424196, 6475.992442342888, 6495.935040649722, 6519.0, 6525.934740652533, 6549.770758023446, 4299.344752270461, 4314.22343978087, 4332.588404101605, 4342.522322544581, 4357.106793107469, 6153.323134455296, 6177.4749146323065, 6217.689115544295, 6236.968815156077, 6330.493560515056, 6009.939900601113, 6016.789412370546, 6017.458428741435, 6080.787172448943, 6084.817455476343, 5852.209951656472, 6032.54755893301, 6052.517133302369, 6053.757849685963, 6080.209572755513, 5935.79467087785, 6001.36985616504, 6001.409626448907, 6006.669633170218, 6027.78902738402, 6116.938830611637, 6120.908186377297, 6133.478654314434, 6146.231721034871, 6159.81520554384, 5766.769329226784, 6011.27864656244, 6023.789167379121, 6035.245594300713, 6064.211652485325], "value": 4437.97167260556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.2787129256864, 787.7636708987302, 787.9527228366296, 792.476965202966, 814.0760237130854, 14838.0, 15774.76337854933, 16065.0, 16085.115318657468, 16114.11372374519, 15049.548513544583, 15050.774238386406, 15082.09507429555, 15086.773698394532, 15208.923955380234, 842.5534466732641, 854.5001174313019, 865.926396256319, 870.2168048756107, 871.2420194430854, 860.802015536427, 861.3195575495382, 864.6282098697588, 865.4980111535294, 867.1025488619281, 908.731924082394, 919.6183583812709, 921.8755468011833, 921.9216366608846, 922.1930810540777, 900.3202582050575, 902.8149229407956, 907.7095329494564, 908.7818923458323, 908.9636414543411, 661.9635920024397, 663.1346093348227, 665.1884700665181, 665.6339013542581, 668.906353110565, 15357.46248881295, 15393.692126157413, 15424.460143895021, 15440.073595584188, 15531.611709707235, 15633.609159770984, 15846.286917088644, 15986.200689965455, 16091.597710057225, 16213.2704028319, 11812.114091443176, 11968.760624787456, 12040.578579749754, 12103.0, 12244.0, 3573.1424458130123, 3612.096975756061, 3622.7826330420257, 3686.189038411545, 3737.1965027519213, 63703.36296637021, 63799.362006380274, 63815.68092159556, 64098.35901641017, 64717.676411618115, 11746.471408786625, 11953.701157471132, 12208.694782630506, 12314.384280785926, 12348.691282717824, 20350.59298814045, 20573.279935202198, 20710.68933965992, 20750.377488675364, 21391.46521336979, 8892.421992570462, 8970.41692289999, 9001.459912405277, 9042.412243204171, 9130.178283954476, 4942.88846014589, 4997.075541024849, 5010.0, 5059.8988020239385, 5082.567981721521, 3764.811759412073, 3870.43878637596, 3873.496445462128, 3874.2638898609175, 3879.515060617423, 654.5974225851068, 666.8899631560738, 674.3391476353104, 678.2335960364757, 703.8170075780232, 723.4357201382929, 725.8620862036196, 733.6955163607043, 742.3689863615883, 751.8684380008053, 9320.0, 10256.743581410525, 10894.836577451344, 11118.722031949266, 11234.606788762354, 727.396261103283, 735.3565630073685, 760.9384908053274, 763.3092051693227, 780.6994307191773, 4487.0, 4664.603508701731, 4696.788644511005, 4723.338732577442, 4736.573708366194, 72746.0, 72817.63591182115, 73590.0, 74350.0, 74522.0, 72844.0, 80445.19554804494, 98740.50629746805, 99462.50268748609, 101387.0, 59758.0, 87775.56112219526, 89943.0, 91949.0, 92600.07399925914, 9272.72181834546, 9364.672236471692, 9391.624335026523, 9415.764605884908, 9472.242220622196, 54527.0, 55110.44889551053, 55163.0, 56145.71927140338, 56281.0, 56805.71597141988, 77873.22126778886, 79242.72212852324, 80243.59878200805, 80445.0, 12299.631011069681, 12622.368881555702, 12648.241105533698, 12847.93576032114, 12856.678583035498, 13519.729605408034, 14071.372053327283, 14178.645533861736, 14231.71536569242, 14239.715205696035, 12670.493180272686, 12736.87263127394, 12935.935320323339, 12955.0, 12985.220886746825, 12597.68505787326, 12599.811002835148, 13107.344632768514, 13229.80155297652, 13363.799543007057, 12769.425375857923, 12822.679433013876, 12831.871681283441, 12837.486500539873, 13161.736765264832, 10419.739506512398, 10580.523876425425, 10714.839277411002, 10849.376897267908, 10874.401907895142, 10010.531126433047, 10113.69658910234, 10129.442880641636, 10208.93019355751, 10288.434136122585], "value": 7542.77425885834, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 111.0, 110.0, 111.0, 111.0, 111.0, 109.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 123.0, 154.0, 178.0, 133.0, 160.0, 156.0, 129.0, 179.0, 125.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 165.0, 162.0, 162.0, 163.0, 163.0, 163.0, 166.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 184.0, 76.0, 76.0, 76.0, 77.0, 179.0, 76.0], "value": 97.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 143.0, 85.0, 86.0, 84.0, 134.0, 86.0, 85.0, 140.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 57.0, 57.0, 56.0, 55.0, 54.0, 59.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 78.0, 77.0, 78.0, 78.0, 81.0, 107.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 124.0, 131.0, 131.0, 124.0, 127.0, 124.0, 130.0, 133.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 157.0, 154.0, 158.0, 158.0, 157.0, 152.0, 160.0, 155.0, 154.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 67.0, 64.0, 61.0, 63.0, 62.0, 61.0, 61.0], "value": 62.9, "unit": "score"}]}]} 04:33:33 INFO - Return code: 0 04:33:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:33 ERROR - # TBPL SUCCESS # 04:33:33 INFO - Running post-action listener: _resource_record_post_action 04:33:33 INFO - ##### 04:33:33 INFO - ##### Finished run-tests step (success) 04:33:33 INFO - ##### 04:33:33 INFO - Running post-run listener: _resource_record_post_run 04:33:34 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287350784; Read time: 0; Write time: 124564 04:33:34 INFO - TinderboxPrint: CPU usage
13.4% 04:33:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:33:34 INFO - TinderboxPrint: I/O write bytes / time
287,350,784 / 124,564 04:33:34 INFO - TinderboxPrint: CPU idle
8,185.6 (86.6%) 04:33:34 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 04:33:34 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:34 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 69439488; Read time: 0; Write time: 34196 04:33:34 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 217083904; Read time: 0; Write time: 90336 04:33:34 INFO - Running post-run listener: _upload_blobber_files 04:33:34 INFO - Blob upload gear active. 04:33:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:33:34 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'] 04:33:34 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 04:33:34 INFO - Traceback (most recent call last): 04:33:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 04:33:34 INFO - main() 04:33:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 04:33:34 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 04:33:34 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 04:33:34 INFO - return set(response.json().get('whitelist', [])) 04:33:34 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 04:33:34 INFO - return json.loads(self.text or self.content, **kwargs) 04:33:34 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 04:33:34 INFO - return _default_decoder.decode(s) 04:33:34 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 04:33:34 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 04:33:34 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 04:33:34 INFO - raise ValueError("No JSON object could be decoded") 04:33:34 INFO - ValueError: No JSON object could be decoded 04:33:35 ERROR - Return code: 1 04:33:35 INFO - Setting buildbot property blobber_files to {} 04:33:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:35 INFO - Contents: 04:33:35 INFO - blobber_files:{} 04:33:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:35 INFO - Copying logs to upload dir... 04:33:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1669.229289 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 49 secs) (at 2016-08-28 04:33:34.500363) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:34.503404) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:34.553662) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:34.553951) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472382343.469533-572219416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004741 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:34.604012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:34.604387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:34.604767) ========= ========= Total master_lag: 0.16 =========