builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1472382346.83 results: success (0) buildid: 20160826110814 builduid: 0dbeb50956e042d4ac8dadee4f76f40d revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.826446) ========= 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:46.826887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.827196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.841836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.842210) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-28 04:05:48-- 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% 46.7M=0s 2016-08-28 04:05:48 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.993568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.993882) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020216 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.044003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-28 04:05:47.044383) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-28 04:05:48,281 truncating revision to first 12 chars 2016-08-28 04:05:48,281 Setting DEBUG logging. 2016-08-28 04:05:48,281 attempt 1/10 2016-08-28 04:05:48,281 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:49,988 unpacking tar archive at: mozilla-beta-6d0c7b6a6ae1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.049426 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-28 04:05:49.107269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:49.107597) ========= script_repo_revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:49.107992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:49.108286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:49.117413) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 49 secs) (at 2016-08-28 04:05:49.117693) ========= /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=bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:50 INFO - MultiFileLogger online at 20160828 04:05:50 in /builds/slave/test 04:05:50 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:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:50 INFO - {'append_to_log': False, 04:05:50 INFO - 'base_work_dir': '/builds/slave/test', 04:05:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:05:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:50 INFO - 'branch': 'Mozilla-Beta', 04:05:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:50 INFO - 'config_files': ('talos/linux_config.py',), 04:05:50 INFO - 'default_actions': ('clobber', 04:05:50 INFO - 'read-buildbot-config', 04:05:50 INFO - 'download-and-extract', 04:05:50 INFO - 'populate-webroot', 04:05:50 INFO - 'create-virtualenv', 04:05:50 INFO - 'install', 04:05:50 INFO - 'run-tests'), 04:05:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:50 INFO - 'download_minidump_stackwalk': True, 04:05:50 INFO - 'download_symbols': 'ondemand', 04:05:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:50 INFO - 'installer_path': 'installer.exe', 04:05:50 INFO - 'log_level': 'info', 04:05:50 INFO - 'log_name': 'talos', 04:05:50 INFO - 'log_to_console': True, 04:05:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:50 INFO - 'opt_config_files': (), 04:05:50 INFO - 'pip_index': False, 04:05:50 INFO - 'sps_profile': False, 04:05:50 INFO - 'sps_profile_interval': 0, 04:05:50 INFO - 'suite': 'dromaeojs-e10s', 04:05:50 INFO - 'system_bits': '32', 04:05:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:50 INFO - 'title': 'talos-linux64-ix-055', 04:05:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:50 INFO - 'use_talos_json': True, 04:05:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:50 INFO - 'work_dir': 'build'} 04:05:50 INFO - ##### 04:05:50 INFO - ##### Running clobber step. 04:05:50 INFO - ##### 04:05:50 INFO - Running pre-action listener: _resource_record_pre_action 04:05:50 INFO - Running main action method: clobber 04:05:50 INFO - rmtree: /builds/slave/test/build 04:05:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:50 INFO - Running post-action listener: _resource_record_post_action 04:05:50 INFO - ##### 04:05:50 INFO - ##### Finished clobber step (success) 04:05:50 INFO - ##### 04:05:50 INFO - ##### 04:05:50 INFO - ##### Running read-buildbot-config step. 04:05:50 INFO - ##### 04:05:50 INFO - Running pre-action listener: _resource_record_pre_action 04:05:50 INFO - Running main action method: read_buildbot_config 04:05:50 INFO - Using buildbot properties: 04:05:50 INFO - { 04:05:50 INFO - "project": "", 04:05:50 INFO - "product": "firefox", 04:05:50 INFO - "script_repo_revision": "production", 04:05:50 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:05:50 INFO - "repository": "", 04:05:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:05:50 INFO - "buildid": "20160826110814", 04:05:50 INFO - "pgo_build": "True", 04:05:50 INFO - "basedir": "/builds/slave/test", 04:05:50 INFO - "buildnumber": 154, 04:05:50 INFO - "slavename": "talos-linux64-ix-055", 04:05:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:50 INFO - "platform": "ubuntu64_hw", 04:05:50 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:05:50 INFO - "branch": "mozilla-beta", 04:05:50 INFO - "repo_path": "releases/mozilla-beta", 04:05:50 INFO - "revision": "6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f", 04:05:50 INFO - "stage_platform": "linux64-pgo", 04:05:50 INFO - "builduid": "0dbeb50956e042d4ac8dadee4f76f40d", 04:05:50 INFO - "slavebuilddir": "test" 04:05:50 INFO - } 04:05:50 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:50 INFO - Running post-action listener: _resource_record_post_action 04:05:50 INFO - ##### 04:05:50 INFO - ##### Finished read-buildbot-config step (success) 04:05:50 INFO - ##### 04:05:50 INFO - ##### 04:05:50 INFO - ##### Running download-and-extract step. 04:05:50 INFO - ##### 04:05:50 INFO - Running pre-action listener: _resource_record_pre_action 04:05:50 INFO - Running main action method: download_and_extract 04:05:50 INFO - mkdir: /builds/slave/test/build/tests 04:05:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:05:50 INFO - retry: Failed, sleeping 30 seconds before retrying 04:06:20 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:20 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:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:06:20 INFO - retry: Failed, sleeping 60 seconds before retrying 04:07:21 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: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.test_packages.json 04:07:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:07:21 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:21 INFO - Caught exception: HTTP Error 404: Not Found 04:07:21 INFO - Caught exception: HTTP Error 404: Not Found 04:07:21 INFO - Caught exception: HTTP Error 404: Not Found 04:07:21 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:21 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:21 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:21 INFO - Downloaded 1327 bytes. 04:07:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:21 INFO - Using the following test package requirements: 04:07:21 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:21 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:21 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 04:07:21 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'jsshell-linux-x86_64.zip'], 04:07:21 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:21 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:21 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 04:07:21 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 04:07:21 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:21 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:21 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:21 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07: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:07:21 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: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.common.tests.zip 04:07: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.common.tests.zip 04:07: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.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07: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.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: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.common.tests.zip 04:07:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:07:21 INFO - retry: Failed, sleeping 30 seconds before retrying 04:07: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.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: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.common.tests.zip 04:07:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:07:51 INFO - retry: Failed, sleeping 60 seconds before retrying 04:08: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.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: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.common.tests.zip 04:08:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:08: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.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 04:08:51 INFO - Caught exception: HTTP Error 404: Not Found 04:08:51 INFO - Caught exception: HTTP Error 404: Not Found 04:08:51 INFO - Caught exception: HTTP Error 404: Not Found 04:08:51 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:51 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: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.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:52 INFO - Downloaded 21969046 bytes. 04:08:52 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:52 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:53 INFO - Return code: 0 04:08:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:08:53 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:23 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:23 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:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:09:23 INFO - retry: Failed, sleeping 60 seconds before retrying 04:10:23 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:23 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:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:10:23 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:23 INFO - Caught exception: HTTP Error 404: Not Found 04:10:23 INFO - Caught exception: HTTP Error 404: Not Found 04:10:23 INFO - Caught exception: HTTP Error 404: Not Found 04:10:23 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:23 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:23 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:24 INFO - Downloaded 21969046 bytes. 04:10:24 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:24 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:25 INFO - Return code: 0 04:10:25 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:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:10:25 INFO - retry: Failed, sleeping 30 seconds before retrying 04:10:55 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:56 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:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:10:56 INFO - retry: Failed, sleeping 60 seconds before retrying 04:11:56 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:56 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:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:11:56 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:56 INFO - Caught exception: HTTP Error 404: Not Found 04:11:56 INFO - Caught exception: HTTP Error 404: Not Found 04:11:56 INFO - Caught exception: HTTP Error 404: Not Found 04:11:56 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:56 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:56 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:56 INFO - Downloaded 10833369 bytes. 04:11:56 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:56 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:57 INFO - Return code: 0 04:11:57 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:57 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:57 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:57 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:57 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:57 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:57 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:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:11:57 INFO - retry: Failed, sleeping 30 seconds before retrying 04:12:27 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:27 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:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:12:27 INFO - retry: Failed, sleeping 60 seconds before retrying 04:13:27 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:27 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:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:13:27 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:27 INFO - Caught exception: HTTP Error 404: Not Found 04:13:27 INFO - Caught exception: HTTP Error 404: Not Found 04:13:27 INFO - Caught exception: HTTP Error 404: Not Found 04:13:27 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:27 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:27 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:28 INFO - Downloaded 55208267 bytes. 04:13:28 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:28 INFO - mkdir: /builds/slave/test/properties 04:13:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:28 INFO - Contents: 04:13:28 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:28 INFO - Running post-action listener: _resource_record_post_action 04:13:28 INFO - Running post-action listener: set_extra_try_arguments 04:13:28 INFO - ##### 04:13:28 INFO - ##### Finished download-and-extract step (success) 04:13:28 INFO - ##### 04:13:28 INFO - ##### 04:13:28 INFO - ##### Running populate-webroot step. 04:13:28 INFO - ##### 04:13:28 INFO - Running pre-action listener: _resource_record_pre_action 04:13:28 INFO - Running main action method: populate_webroot 04:13:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:28 INFO - '--tppagecycles', 04:13:28 INFO - '7'], 04:13:28 INFO - 'tests': ['tsvgm']}}, 04:13:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['damp', 'tps']}, 04:13:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'tests': ['damp', 'tps']}, 04:13:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['dromaeo_dom']}, 04:13:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['a11yr', 04:13:28 INFO - 'ts_paint', 04:13:28 INFO - 'tpaint', 04:13:28 INFO - 'sessionrestore', 04:13:28 INFO - 'sessionrestore_no_auto_restore', 04:13:28 INFO - 'tabpaint']}, 04:13:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:28 INFO - 'ts_paint', 04:13:28 INFO - 'tpaint', 04:13:28 INFO - 'sessionrestore', 04:13:28 INFO - 'sessionrestore_no_auto_restore', 04:13:28 INFO - 'tabpaint']}, 04:13:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:28 INFO - 'ts_paint', 04:13:28 INFO - 'tpaint', 04:13:28 INFO - 'sessionrestore', 04:13:28 INFO - 'sessionrestore_no_auto_restore', 04:13:28 INFO - 'tabpaint']}, 04:13:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:28 INFO - 'ts_paint', 04:13:28 INFO - 'tpaint', 04:13:28 INFO - 'sessionrestore', 04:13:28 INFO - 'sessionrestore_no_auto_restore', 04:13:28 INFO - 'tabpaint']}, 04:13:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['a11yr', 04:13:28 INFO - 'ts_paint', 04:13:28 INFO - 'tpaint', 04:13:28 INFO - 'sessionrestore', 04:13:28 INFO - 'sessionrestore_no_auto_restore', 04:13:28 INFO - 'tabpaint']}, 04:13:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['a11yr', 04:13:28 INFO - 'ts_paint', 04:13:28 INFO - 'tpaint', 04:13:28 INFO - 'sessionrestore', 04:13:28 INFO - 'sessionrestore_no_auto_restore', 04:13:28 INFO - 'tabpaint']}, 04:13:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['tsvgx', 04:13:28 INFO - 'tsvgr_opacity', 04:13:28 INFO - 'tart', 04:13:28 INFO - 'tscrollx', 04:13:28 INFO - 'cart']}, 04:13:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:28 INFO - 'tsvgr_opacity', 04:13:28 INFO - 'tart', 04:13:28 INFO - 'tscrollx', 04:13:28 INFO - 'cart']}, 04:13:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'talos_options': ['--disable-e10s'], 04:13:28 INFO - 'tests': ['tp5o']}, 04:13:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'tests': ['tp5o']}, 04:13:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'talos_options': ['--disable-e10s', 04:13:28 INFO - '--xperf_path', 04:13:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:28 INFO - 'tests': ['tp5n']}, 04:13:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:28 INFO - 'talos_options': ['--xperf_path', 04:13:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:28 INFO - 'tests': ['tp5n']}}, 04:13:28 INFO - 'talos.zip': {'path': '', 04:13:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:28 INFO - Running post-action listener: _resource_record_post_action 04:13:28 INFO - ##### 04:13:28 INFO - ##### Finished populate-webroot step (success) 04:13:28 INFO - ##### 04:13:28 INFO - ##### 04:13:28 INFO - ##### Running create-virtualenv step. 04:13:28 INFO - ##### 04:13:28 INFO - Running pre-action listener: _resource_record_pre_action 04:13:28 INFO - Running main action method: create_virtualenv 04:13:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:28 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:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:29 INFO - Using real prefix '/usr' 04:13:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:31 INFO - Installing pip.................done. 04:13:31 INFO - Return code: 0 04:13:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:13:31 INFO - Using env: {'DISPLAY': ':0', 04:13:31 INFO - 'HOME': '/home/cltbld', 04:13:31 INFO - 'LANG': 'en_US.UTF-8', 04:13:31 INFO - 'LANGUAGE': 'en_US:en', 04:13:31 INFO - 'LOGNAME': 'cltbld', 04:13:31 INFO - 'MAIL': '/var/mail/cltbld', 04:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:31 INFO - 'MOZ_NO_REMOTE': '1', 04:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:31 INFO - 'NO_EM_RESTART': '1', 04:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:31 INFO - 'PWD': '/builds/slave/test', 04:13:31 INFO - 'SHELL': '/bin/bash', 04:13:31 INFO - 'SHLVL': '1', 04:13:31 INFO - 'TERM': 'linux', 04:13:31 INFO - 'TMOUT': '86400', 04:13:31 INFO - 'USER': 'cltbld', 04:13:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:31 INFO - '_': '/tools/buildbot/bin/python'} 04:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:31 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:31 INFO - Cleaning up... 04:13:31 INFO - Return code: 0 04:13:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:13:31 INFO - Using env: {'DISPLAY': ':0', 04:13:31 INFO - 'HOME': '/home/cltbld', 04:13:31 INFO - 'LANG': 'en_US.UTF-8', 04:13:31 INFO - 'LANGUAGE': 'en_US:en', 04:13:31 INFO - 'LOGNAME': 'cltbld', 04:13:31 INFO - 'MAIL': '/var/mail/cltbld', 04:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:31 INFO - 'MOZ_NO_REMOTE': '1', 04:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:31 INFO - 'NO_EM_RESTART': '1', 04:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:31 INFO - 'PWD': '/builds/slave/test', 04:13:31 INFO - 'SHELL': '/bin/bash', 04:13:31 INFO - 'SHLVL': '1', 04:13:31 INFO - 'TERM': 'linux', 04:13:31 INFO - 'TMOUT': '86400', 04:13:31 INFO - 'USER': 'cltbld', 04:13:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:31 INFO - '_': '/tools/buildbot/bin/python'} 04:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:31 INFO - Downloading/unpacking psutil>=3.1.1 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:33 INFO - Installing collected packages: psutil 04:13:33 INFO - Running setup.py install for psutil 04:13:33 INFO - building 'psutil._psutil_linux' extension 04:13:33 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:34 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:34 INFO - building 'psutil._psutil_posix' extension 04:13:34 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:34 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:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:34 INFO - Successfully installed psutil 04:13:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:34 INFO - '_': '/tools/buildbot/bin/python'} 04:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 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:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:36 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:36 INFO - Installing collected packages: mozsystemmonitor 04:13:36 INFO - Running setup.py install for mozsystemmonitor 04:13:36 INFO - Successfully installed mozsystemmonitor 04:13:36 INFO - Cleaning up... 04:13:36 INFO - Return code: 0 04:13:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:36 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:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:36 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:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:36 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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:36 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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 04:13:36 INFO - 'HOME': '/home/cltbld', 04:13:36 INFO - 'LANG': 'en_US.UTF-8', 04:13:36 INFO - 'LANGUAGE': 'en_US:en', 04:13:36 INFO - 'LOGNAME': 'cltbld', 04:13:36 INFO - 'MAIL': '/var/mail/cltbld', 04:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:36 INFO - 'MOZ_NO_REMOTE': '1', 04:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:36 INFO - 'NO_EM_RESTART': '1', 04:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:36 INFO - 'PWD': '/builds/slave/test', 04:13:36 INFO - 'SHELL': '/bin/bash', 04:13:36 INFO - 'SHLVL': '1', 04:13:36 INFO - 'TERM': 'linux', 04:13:36 INFO - 'TMOUT': '86400', 04:13:36 INFO - 'USER': 'cltbld', 04:13:36 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:36 INFO - '_': '/tools/buildbot/bin/python'} 04:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:38 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:38 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:38 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:38 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:38 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:38 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:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:39 INFO - warning: no files found matching '*.txt' 04:13:39 INFO - no previously-included directories found matching 'build' 04:13:39 INFO - no previously-included directories found matching 'dist' 04:13:39 INFO - no previously-included directories found matching '.git*' 04:13:39 INFO - Installing collected packages: jsonschema, functools32 04:13:39 INFO - Running setup.py install for functools32 04:13:39 INFO - warning: no files found matching '*.txt' 04:13:39 INFO - no previously-included directories found matching 'build' 04:13:39 INFO - no previously-included directories found matching 'dist' 04:13:39 INFO - no previously-included directories found matching '.git*' 04:13:39 INFO - Successfully installed jsonschema functools32 04:13:39 INFO - Cleaning up... 04:13:39 INFO - Return code: 0 04:13:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:13:39 INFO - Using env: {'DISPLAY': ':0', 04:13:39 INFO - 'HOME': '/home/cltbld', 04:13:39 INFO - 'LANG': 'en_US.UTF-8', 04:13:39 INFO - 'LANGUAGE': 'en_US:en', 04:13:39 INFO - 'LOGNAME': 'cltbld', 04:13:39 INFO - 'MAIL': '/var/mail/cltbld', 04:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:39 INFO - 'MOZ_NO_REMOTE': '1', 04:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:39 INFO - 'NO_EM_RESTART': '1', 04:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:39 INFO - 'PWD': '/builds/slave/test', 04:13:39 INFO - 'SHELL': '/bin/bash', 04:13:39 INFO - 'SHLVL': '1', 04:13:39 INFO - 'TERM': 'linux', 04:13:39 INFO - 'TMOUT': '86400', 04:13:39 INFO - 'USER': 'cltbld', 04:13:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:39 INFO - '_': '/tools/buildbot/bin/python'} 04:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:41 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:41 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:41 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:41 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:41 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:41 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:42 INFO - Downloading docopt-0.6.1.tar.gz 04:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:42 INFO - Running setup.py install for blobuploader 04:13:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:42 INFO - Running setup.py install for requests 04:13:42 INFO - Running setup.py install for docopt 04:13:42 INFO - Successfully installed blobuploader requests docopt 04:13:42 INFO - Cleaning up... 04:13:42 INFO - Return code: 0 04:13:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:42 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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 04:13:42 INFO - 'HOME': '/home/cltbld', 04:13:42 INFO - 'LANG': 'en_US.UTF-8', 04:13:42 INFO - 'LANGUAGE': 'en_US:en', 04:13:42 INFO - 'LOGNAME': 'cltbld', 04:13:42 INFO - 'MAIL': '/var/mail/cltbld', 04:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:42 INFO - 'MOZ_NO_REMOTE': '1', 04:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:42 INFO - 'NO_EM_RESTART': '1', 04:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:42 INFO - 'PWD': '/builds/slave/test', 04:13:42 INFO - 'SHELL': '/bin/bash', 04:13:42 INFO - 'SHLVL': '1', 04:13:42 INFO - 'TERM': 'linux', 04:13:42 INFO - 'TMOUT': '86400', 04:13:42 INFO - 'USER': 'cltbld', 04:13:42 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:42 INFO - '_': '/tools/buildbot/bin/python'} 04:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:43 INFO - Running setup.py (path:/tmp/pip-1svCdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:43 INFO - Running setup.py (path:/tmp/pip-bepzsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:43 INFO - Running setup.py (path:/tmp/pip-0LIfdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:43 INFO - Running setup.py (path:/tmp/pip-SG7snP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:43 INFO - Running setup.py (path:/tmp/pip-1wA_06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:43 INFO - Running setup.py (path:/tmp/pip-HcFguG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:43 INFO - Running setup.py (path:/tmp/pip-NwkZr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:43 INFO - Running setup.py (path:/tmp/pip-xjbBwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:43 INFO - Running setup.py (path:/tmp/pip-RkE5JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:43 INFO - Running setup.py (path:/tmp/pip-F91to3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:43 INFO - Running setup.py (path:/tmp/pip-rXPEHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:43 INFO - Running setup.py (path:/tmp/pip-y1JuXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:43 INFO - Running setup.py (path:/tmp/pip-2wOBQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:43 INFO - Running setup.py (path:/tmp/pip-mFgQDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:44 INFO - Running setup.py (path:/tmp/pip-xgcGaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:44 INFO - Running setup.py (path:/tmp/pip-kmgOzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:44 INFO - Running setup.py (path:/tmp/pip-5ckVZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:44 INFO - Running setup.py install for manifestparser 04:13:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Running setup.py install for mozcrash 04:13:44 INFO - Running setup.py install for mozdebug 04:13:44 INFO - Running setup.py install for mozdevice 04:13:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Running setup.py install for mozfile 04:13:44 INFO - Running setup.py install for mozhttpd 04:13:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Running setup.py install for mozinfo 04:13:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Running setup.py install for mozInstall 04:13:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Running setup.py install for mozleak 04:13:45 INFO - Running setup.py install for mozlog 04:13:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Running setup.py install for moznetwork 04:13:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Running setup.py install for mozprocess 04:13:45 INFO - Running setup.py install for mozprofile 04:13:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Running setup.py install for mozrunner 04:13:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:45 INFO - Running setup.py install for mozscreenshot 04:13:45 INFO - Running setup.py install for moztest 04:13:45 INFO - Running setup.py install for mozversion 04:13:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:46 INFO - Cleaning up... 04:13:46 INFO - Return code: 0 04:13:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:46 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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:46 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:46 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:46 INFO - Using env: {'DISPLAY': ':0', 04:13:46 INFO - 'HOME': '/home/cltbld', 04:13:46 INFO - 'LANG': 'en_US.UTF-8', 04:13:46 INFO - 'LANGUAGE': 'en_US:en', 04:13:46 INFO - 'LOGNAME': 'cltbld', 04:13:46 INFO - 'MAIL': '/var/mail/cltbld', 04:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:46 INFO - 'MOZ_NO_REMOTE': '1', 04:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:46 INFO - 'NO_EM_RESTART': '1', 04:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:46 INFO - 'PWD': '/builds/slave/test', 04:13:46 INFO - 'SHELL': '/bin/bash', 04:13:46 INFO - 'SHLVL': '1', 04:13:46 INFO - 'TERM': 'linux', 04:13:46 INFO - 'TMOUT': '86400', 04:13:46 INFO - 'USER': 'cltbld', 04:13:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:46 INFO - '_': '/tools/buildbot/bin/python'} 04:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:46 INFO - Running setup.py (path:/tmp/pip-N_nLtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:46 INFO - Running setup.py (path:/tmp/pip-f5UcQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:46 INFO - Running setup.py (path:/tmp/pip-Ke_CWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:46 INFO - Running setup.py (path:/tmp/pip-EeDkPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:46 INFO - Running setup.py (path:/tmp/pip-LqsNEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:46 INFO - Running setup.py (path:/tmp/pip-QEwJ1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:46 INFO - Running setup.py (path:/tmp/pip-EAoomy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:46 INFO - Running setup.py (path:/tmp/pip-TLvGjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:46 INFO - Running setup.py (path:/tmp/pip-QtTnHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:46 INFO - Running setup.py (path:/tmp/pip-2bbeha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:46 INFO - Running setup.py (path:/tmp/pip-MUT6Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:47 INFO - Running setup.py (path:/tmp/pip-0lW8HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:47 INFO - Running setup.py (path:/tmp/pip-1wgNOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:47 INFO - Running setup.py (path:/tmp/pip-IfNcpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:47 INFO - Running setup.py (path:/tmp/pip-E6XCTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:47 INFO - Running setup.py (path:/tmp/pip-_6fb77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:47 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:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:47 INFO - Running setup.py (path:/tmp/pip-LspmVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:49 INFO - Downloading blessings-1.6.tar.gz 04:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:49 INFO - Installing collected packages: blessings 04:13:49 INFO - Running setup.py install for blessings 04:13:49 INFO - Successfully installed blessings 04:13:49 INFO - Cleaning up... 04:13:49 INFO - Return code: 0 04:13:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:49 INFO - Reading from file tmpfile_stdout 04:13:49 INFO - Current package versions: 04:13:49 INFO - argparse == 1.2.1 04:13:49 INFO - blessings == 1.6 04:13:49 INFO - blobuploader == 1.2.4 04:13:49 INFO - docopt == 0.6.1 04:13:49 INFO - functools32 == 3.2.3-2 04:13:49 INFO - jsonschema == 2.5.1 04:13:49 INFO - manifestparser == 1.1 04:13:49 INFO - mozInstall == 1.12 04:13:49 INFO - mozcrash == 0.17 04:13:49 INFO - mozdebug == 0.1 04:13:49 INFO - mozdevice == 0.48 04:13:49 INFO - mozfile == 1.2 04:13:49 INFO - mozhttpd == 0.7 04:13:49 INFO - mozinfo == 0.9 04:13:49 INFO - mozleak == 0.1 04:13:49 INFO - mozlog == 3.2 04:13:49 INFO - moznetwork == 0.27 04:13:49 INFO - mozprocess == 0.23 04:13:49 INFO - mozprofile == 0.28 04:13:49 INFO - mozrunner == 6.12 04:13:49 INFO - mozscreenshot == 0.1 04:13:49 INFO - mozsystemmonitor == 0.3 04:13:49 INFO - moztest == 0.7 04:13:49 INFO - mozversion == 1.4 04:13:49 INFO - psutil == 3.1.1 04:13:49 INFO - requests == 1.2.3 04:13:49 INFO - wsgiref == 0.1.2 04:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:49 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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 04:13:49 INFO - 'HOME': '/home/cltbld', 04:13:49 INFO - 'LANG': 'en_US.UTF-8', 04:13:49 INFO - 'LANGUAGE': 'en_US:en', 04:13:49 INFO - 'LOGNAME': 'cltbld', 04:13:49 INFO - 'MAIL': '/var/mail/cltbld', 04:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:49 INFO - 'MOZ_NO_REMOTE': '1', 04:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:49 INFO - 'NO_EM_RESTART': '1', 04:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:49 INFO - 'PWD': '/builds/slave/test', 04:13:49 INFO - 'SHELL': '/bin/bash', 04:13:49 INFO - 'SHLVL': '1', 04:13:49 INFO - 'TERM': 'linux', 04:13:49 INFO - 'TMOUT': '86400', 04:13:49 INFO - 'USER': 'cltbld', 04:13:49 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:49 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 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:50 INFO - Cleaning up... 04:13:50 INFO - Return code: 0 04:13:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 04:13:50 INFO - 'HOME': '/home/cltbld', 04:13:50 INFO - 'LANG': 'en_US.UTF-8', 04:13:50 INFO - 'LANGUAGE': 'en_US:en', 04:13:50 INFO - 'LOGNAME': 'cltbld', 04:13:50 INFO - 'MAIL': '/var/mail/cltbld', 04:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:50 INFO - 'MOZ_NO_REMOTE': '1', 04:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:50 INFO - 'NO_EM_RESTART': '1', 04:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:50 INFO - 'PWD': '/builds/slave/test', 04:13:50 INFO - 'SHELL': '/bin/bash', 04:13:50 INFO - 'SHLVL': '1', 04:13:50 INFO - 'TERM': 'linux', 04:13:50 INFO - 'TMOUT': '86400', 04:13:50 INFO - 'USER': 'cltbld', 04:13:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:50 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:50 INFO - Cleaning up... 04:13:50 INFO - Return code: 0 04:13:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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 0x7f2d8bd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b67020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 04:13:50 INFO - 'HOME': '/home/cltbld', 04:13:50 INFO - 'LANG': 'en_US.UTF-8', 04:13:50 INFO - 'LANGUAGE': 'en_US:en', 04:13:50 INFO - 'LOGNAME': 'cltbld', 04:13:50 INFO - 'MAIL': '/var/mail/cltbld', 04:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:50 INFO - 'MOZ_NO_REMOTE': '1', 04:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:50 INFO - 'NO_EM_RESTART': '1', 04:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:50 INFO - 'PWD': '/builds/slave/test', 04:13:50 INFO - 'SHELL': '/bin/bash', 04:13:50 INFO - 'SHLVL': '1', 04:13:50 INFO - 'TERM': 'linux', 04:13:50 INFO - 'TMOUT': '86400', 04:13:50 INFO - 'USER': 'cltbld', 04:13:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:50 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 INFO - Downloading/unpacking flake8 04:13:50 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:50 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:50 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:50 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:50 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:50 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:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:52 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:52 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:52 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:52 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:52 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:52 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:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:52 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:52 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:52 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:52 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:52 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:52 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:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:52 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:52 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:52 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:52 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:52 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:52 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:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:53 INFO - no previously-included directories found matching 'docs/_build' 04:13:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:53 INFO - Running setup.py install for pep8 04:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:53 INFO - no previously-included directories found matching 'docs/_build' 04:13:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:53 INFO - Cleaning up... 04:13:53 INFO - Return code: 0 04:13:53 INFO - Running post-action listener: _resource_record_post_action 04:13:53 INFO - Running post-action listener: _start_resource_monitoring 04:13:53 INFO - Starting resource monitoring. 04:13:53 INFO - ##### 04:13:53 INFO - ##### Finished create-virtualenv step (success) 04:13:53 INFO - ##### 04:13:53 INFO - ##### 04:13:53 INFO - ##### Running install step. 04:13:53 INFO - ##### 04:13:53 INFO - Running pre-action listener: _resource_record_pre_action 04:13:53 INFO - Running main action method: install 04:13:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:53 INFO - Reading from file tmpfile_stdout 04:13:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:53 INFO - Reading from file tmpfile_stdout 04:13:53 INFO - Output received: 04:13:53 INFO - Usage: mozinstall [options] installer 04:13:53 INFO - Options: 04:13:53 INFO - -h, --help show this help message and exit 04:13:53 INFO - -d DEST, --destination=DEST 04:13:53 INFO - Directory to install application into. [default: 04:13:53 INFO - "/builds/slave/test"] 04:13:53 INFO - --app=APP Application being installed. [default: firefox] 04:13:53 INFO - mkdir: /builds/slave/test/build/application 04:13:53 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:53 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:07 INFO - Reading from file tmpfile_stdout 04:14:07 INFO - Output received: 04:14:07 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:07 INFO - Running post-action listener: _resource_record_post_action 04:14:07 INFO - ##### 04:14:07 INFO - ##### Finished install step (success) 04:14:07 INFO - ##### 04:14:07 INFO - ##### 04:14:07 INFO - ##### Running run-tests step. 04:14:07 INFO - ##### 04:14:07 INFO - Running pre-action listener: _resource_record_pre_action 04:14:07 INFO - Running main action method: run_tests 04:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:07 INFO - Python 2.7.3 04:14:07 INFO - Return code: 0 04:14:07 INFO - grabbing minidump binary from tooltool 04:14:07 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:07 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 0x1bf92e0>, '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 0x1b65140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b655d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:07 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:07 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:07 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:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:07 INFO - Return code: 0 04:14:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:08 INFO - Return code: 0 04:14:08 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-055', '--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:08 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-055 --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:08 INFO - Using env: {'DISPLAY': ':0', 04:14:08 INFO - 'HOME': '/home/cltbld', 04:14:08 INFO - 'LANG': 'en_US.UTF-8', 04:14:08 INFO - 'LANGUAGE': 'en_US:en', 04:14:08 INFO - 'LOGNAME': 'cltbld', 04:14:08 INFO - 'MAIL': '/var/mail/cltbld', 04:14:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:08 INFO - 'MOZ_NO_REMOTE': '1', 04:14:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:08 INFO - 'NO_EM_RESTART': '1', 04:14:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:08 INFO - 'PWD': '/builds/slave/test', 04:14:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:08 INFO - 'SHELL': '/bin/bash', 04:14:08 INFO - 'SHLVL': '1', 04:14:08 INFO - 'TERM': 'linux', 04:14:08 INFO - 'TMOUT': '86400', 04:14:08 INFO - 'USER': 'cltbld', 04:14:08 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134', 04:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:08 INFO - '_': '/tools/buildbot/bin/python'} 04:14:08 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-055', '--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:08 INFO - mozversion application_buildid: 20160826110814 04:14:08 INFO - mozversion application_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:08 INFO - mozversion application_display_name: Firefox 04:14:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:08 INFO - mozversion application_name: Firefox 04:14:08 INFO - mozversion application_remotingname: firefox 04:14:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:08 INFO - mozversion application_vendor: Mozilla 04:14:08 INFO - mozversion application_version: 49.0 04:14:08 INFO - mozversion platform_buildid: 20160826110814 04:14:08 INFO - mozversion platform_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:08 INFO - mozversion platform_version: 49.0 04:14:08 INFO - using testdate: 1472382848 04:14:08 INFO - actual date: 1472382848 04:14:08 INFO - starting webserver on 'localhost:55306' 04:14:08 INFO - SUITE-START | Running 2 tests 04:14:08 INFO - TEST-START | dromaeo_css 04:14:08 INFO - operating with platform_type : linux_ 04:14:08 INFO - Initialising browser for dromaeo_css test... 04:14:08 INFO - TEST-INFO | started process 21849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiC8ydo/profile http://localhost:55306/getInfo.html) 04:14:12 INFO - PROCESS | 21849 | __metrics Screen width/height:1600/1200 04:14:12 INFO - PROCESS | 21849 | colorDepth:24 04:14:12 INFO - PROCESS | 21849 | Browser inner width/height: 1024/697 04:14:12 INFO - PROCESS | 21849 | __metrics 04:14:13 ERROR - PROCESS | 21849 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:14:14 INFO - TEST-INFO | 21849: exit 0 04:14:14 INFO - Browser initialized. 04:14:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:14 INFO - TEST-INFO | started process 21978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiC8ydo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:25 INFO - PROCESS | 21978 | RSS: Main: 152715264 04:14:25 INFO - PROCESS | 21978 | 04:15:15 INFO - PROCESS | 21978 | 1472382915488 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:23 INFO - PROCESS | 21978 | Cycle 1(1): loaded http://localhost:55306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55306/tests/dromaeo/cssquery-ext.html) 04:17:24 INFO - PROCESS | 21978 | RSS: Main: 157130752 04:17:24 INFO - PROCESS | 21978 | 04:20:26 INFO - PROCESS | 21978 | Cycle 1(1): loaded http://localhost:55306/tests/dromaeo/cssquery-ext.html (next: http://localhost:55306/tests/dromaeo/cssquery-jquery.html) 04:20:27 INFO - PROCESS | 21978 | RSS: Main: 155160576 04:20:27 INFO - PROCESS | 21978 | 04:23:28 INFO - PROCESS | 21978 | Cycle 1(1): loaded http://localhost:55306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55306/tests/dromaeo/cssquery-mootools.html) 04:23:29 INFO - PROCESS | 21978 | RSS: Main: 154746880 04:23:29 INFO - PROCESS | 21978 | 04:26:31 INFO - PROCESS | 21978 | Cycle 1(1): loaded http://localhost:55306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55306/tests/dromaeo/cssquery-prototype.html) 04:26:31 INFO - PROCESS | 21978 | RSS: Main: 155947008 04:26:31 INFO - PROCESS | 21978 | 04:29:34 INFO - PROCESS | 21978 | Cycle 1(1): loaded http://localhost:55306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55306/tests/dromaeo/cssquery-yui.html) 04:29:34 INFO - PROCESS | 21978 | RSS: Main: 154845184 04:29:34 INFO - PROCESS | 21978 | 04:32:36 INFO - PROCESS | 21978 | Cycle 1(1): loaded http://localhost:55306/tests/dromaeo/cssquery-yui.html (next: http://localhost:55306/tests/dromaeo/cssquery-dojo.html) 04:32:37 INFO - PROCESS | 21978 | RSS: Main: 159068160 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | __start_tp_report 04:32:37 INFO - PROCESS | 21978 | _x_x_mozilla_page_load 04:32:37 INFO - PROCESS | 21978 | _x_x_mozilla_page_load_details 04:32:37 INFO - PROCESS | 21978 | |i|pagename|runs| 04:32:37 INFO - PROCESS | 21978 | |0;dojo.html;3357.73138148948;3384.4754063120195;3410.1474631342157;3419.025577710353;3429.7942123472594;5622.07235806092;5628.943710562893;5652.236948012017;5693.572982026354;5696.544276457884;5656.660600363981;5736.684482353469;5739.971300143494;5749.080147176443;5753.223314852494;5123.871903202422;5159.277701121827;5201.2458193561915;5247.291615631898;5254.500822421864;5068.46781087986;5077.390713114413;5233.816816411427;5240.816571420001;5245.291885595453;5055.494450554952;5095.9745201273945;5110.897782044375;5133.614978876581;5173.922391164136;5108.438071812097;5166.147585648401;5171.172612382001;5179.14544100223;5197.688138711652;4985.675931064469;5012.473690262543;5081.110805609041;5091.592672586221;5104.336436263299;5419.349678038621;5434.375046869621;5492.286002819608;5494.642848214893;5517.724113794295;5955.076963070731;6000.459958603703;6011.549133814938;6014.3985601439945;6015.338312785634;5975.163477113208;6061.575689701723;6061.787837425713;6067.484263837579;6068.908966365508;5653.547716182696;5696.145578163268;5698.031334673115;5698.629589076738;5733.197352370671;6199.442050215412;6225.470834978987;6234.0337247726675;6248.250209974832;6254.843628909313;5775.797847075332;5783.103618939072;5840.883182336414;5960.135780311831;5961.433663801932;6023.789167379208;6037.034074548139;6051.818445446644;6053.848653783691;6062.363451837582;5952.672603006876;5976.312724036705;6002.879942401215;6012.038073908154;6027.60820546663;5923.318818335861;5990.490808281258;6028.969855150696;6036.939630603725;6062.302835173923;4678.1813182692895;4689.62483001359;4699.060187962421;4705.482396936334;4742.19382704941;4170.228507726019;4184.184084103571;4193;4207.621314081747;4256.233877901946;5708.086706127;5762.193292938992;5773.04744717117;5819.94180058194;5837;6046.7278972445465;6096.481799047131;6133.509319254449;6160.9383906161265;6167.784127555514;5714.485696287354;5848.064309710426;5858.677772722456;5870.090136028923;5874.030784920526;5224.869378265497;5256.237845512455;5262.97368513155;5267.446918073624;5281.445448227958;6317.431431171217;6361.2048493938255;6365.108884756138;6369.681515924185;6381.266154392211;6005.819825405245;6050.30421501533;6148.200733904474;6159.353267906805;6171.197744293213;6246.031865060922;6347.111404403295;6370.490360771035;6376.426121649074;6378.298387177314;5937.910931335947;5962.70186490665;5969.403059694169;5971.313298970674;5992.820215393545;6040.244969378828;6101.908471372844;6119.020956646915;6137.3862613738265;6139.3730661373875;5931.792387266598;5966.522678185822;5968.612040217372;5987.221661184019;5990.101484777319;5927.911081333869;5987.670678112746;5995.790147344822;6002.879942401215;6021.909671354845;5731.656100633975;5788.507976821849;5820.417958204146;5886.087656413263;5920.674362910081;6026.668533230714;6042.577019608585;6053.969730151321;6069.817905462844;6074.088886667036;5631.267935168402;5914.112883067574;5928.9407105928385;5930.614510056833;5943.702814859326 04:32:37 INFO - PROCESS | 21978 | |1;ext.html;581.5986968991396;633.1168020611248;643.3502162815556;659.3966520633619;675.1998881325626;41885;45318.773406133005;45620.771896140555;45992;46036.309455358154;46195.53804461954;47200;47279.52720472803;47284.76357618216;47357;8865.556722163883;9019.143181397756;9029.683961061364;9030.413023153507;9044.728658140266;8927.46435213886;9016;9016.504092274956;9016.68441604544;9047.819043619123;8993.865092023625;9002.954985225097;9006.23447007002;9068.319876009293;9087.500187489686;8917.554122293892;8974.551272436418;8985.865212021825;9001.414908030956;9024.593893274818;8854.247388971946;8915.28677705782;8940.68707595231;8950.194482496541;8977.057408972028;42748.78625606852;42867.57132428698;42928.14143717139;42985.35521967173;43077.78461107674;3769.962300377016;3958.6635136013474;3990.2817492851277;4270.208653417263;4330.653547716175;34004.82997585021;34376;34461.138471538165;35098.82450587731;36318.45522317167;4011.805859204202;4092.611201935841;4094.979525102385;4119.8970025749295;4170.16596680665;245778;247053;247745.9999999982;247824;248546;38008.23983520314;39015.609843901766;39240.215195696495;62057.68971155115;62394.376056239766;40452.39321410181;40520.79739601283;40639.18721625551;40646;40744.18511629751;15594.766078508832;15619.21903904823;15673.764893526606;15674.373025079098;15805.841941580667;14604.12375257488;14681.77977330341;14699;14713.852861471463;14741.11553306805;9338.953305233566;9385.483798391155;9433.103855133751;9436.575354109082;9446.055394460636;3621.420572708407;3622.9637703623152;3633.9636603634153;3643.9453408198897;3709.4806727058235;1010.2978429991233;1102.1513434655271;1118.4687273545;1121.5738019552518;1174.770919670673;32950.8352458241;33495.49756753602;33563;33760.32479350399;33808.492872606934;1134.773045390925;1162.9418529073682;1199.5126043705743;1222.7921253386946;1274;17438;17497.650046998988;17598.032108233914;17611.911940440215;17823.287068517373;575160;614809;623946;626759;876853;59998.100028499604;60338.69830650819;60370.39629603648;60379;60389.69805150946;1505.8042454481067;1508.178042966564;1511.871490923262;1520.4602366160075;1555.0358777557985;30715.539266910568;30969.8451507741;31511.527327089654;31643.20891977719;32555.83722081469;51330.23004654858;59879.70060149671;61502;61583.6920815393;66442.33557664361;536845;537230;541758;542761;542811;47965.760171200316;48366.516334836204;48495.5150448491;48909.2663610039;49003.264951026475;53202.73398632982;53638;53689.731551341996;54769;55095.449045509034;42772.35841462318;43033;44223.11553768971;44831.77584112059;45613.54386456093;44508.332375015045;44528.332075018254;44591.55408445874;44671.77664111659;45568;44440.7777961121;44641;44710.3293450605;45830;45831.54168458273;37822.43266350952;38286.61713382942;38959.6104038956;39278.2144357117;39550.80224598858;29546.261343466584;29660.851695742247;30165.849170754005;30260.394792104475;30343.848280758455 04:32:37 INFO - PROCESS | 21978 | |2;jquery.html;428.665640800176;436.28013777267483;438.8880835386976;441.4857040351593;448.1686471595193;18666.160022798973;20006.699899501502;20363.49091272719;21479.355619331407;21494.89252553735;19851.50371240716;20046.49883752907;20079.799202007976;20712;20793.272235471763;5871.471567558919;5946.910796338058;5999.580029397944;6076;6089.208402907616;5770.105633626795;5933.495652869511;5977.7608895644125;5977.88044239115;5988.1317209004665;5905.822825315247;5926.140709597106;5928.614640048383;5932.199153114339;5954;5667.4049224831415;5816.1566572846705;5860.824175274749;5865.85335366615;5894.115882617599;5276.366835979668;5286.709230992294;5298.258243845865;5315.893682126336;5321.973390133025;21206.787932120635;22408.887955560116;24149.275521734202;24258.878705606534;24748;2365.3258821235863;2374.976250237493;2542.4025354041787;2671.7595416412614;2829.2926768307925;10358.948205259001;10485.528151233213;10618.681439556825;10626.893731062668;10772.35365878042;1984.8412127029803;1989.293800700745;2002.8097330753556;2009.2063634864294;2034.440528854562;54362;75475;90419.54790226073;91117;91795;10815.242932994772;11190.608328708457;11221;11272;11325.660230193107;15381.923090384476;15453.922730386501;15454.768178477332;15521.379144834305;15559.688806223812;8272.296854767292;8473.279771219391;8558.400911936105;8578.485290882567;8594.699185528476;7976.364845206719;8085.231902969209;8172.7956801080445;8243.711470098518;8311.667533298722;4610.331501932201;4633.606143477842;4666.346711460398;4686.36734040907;4689.577937985598;1838.4208974173093;1892.2903911033363;1899.819517145869;1919.0980239287512;1934.6034063017048;1049.3598904668147;1073.1843798712878;1088.1675518228562;1116.1182665694173;1116.3246236027248;17495.65008699819;20272.189112435633;20321;20325.593488130155;20411.795882041286;1046.895310468947;1049.464772965793;1069.315637991686;1070.250824422907;1080.6379862746069;10577.62978295756;11380.886191138148;11389.715257118472;11466.656000320003;11469.25449845774;495663;505233;507425;527383;564732;97749.5112524447;98712;100688;101092;101383;1078.541619811577;1102.5699977008974;1154.4285578638628;1172.6892373521023;1176.823476478535;17899.37352192667;17917.731234031762;18042.548936276173;18152.45542633723;18287.542811429288;41939.580604193565;42701.35947960845;42898;43473.130537388446;43777.343339850566;56132.71933640305;57330;59025.70487147537;65086.349136508026;66259;7793.181715919747;8146.674133034612;8150.26647601695;8217;9160;9219.861702074608;9292.349535532718;9658.517074146404;9732.610695572097;9817.312788104764;8633.179847914438;8655.29227796553;8974;9058.094190581152;9130.508626976974;8594.65621375138;8966.910330896868;9001.144891235323;9016.639334426549;9306.255499560155;9120.498372589305;9157.587908544265;9186.265098792213;9274.721758347261;9378.765530861783;13516.5269215577;14069.155850648995;14094.154350738989;14104.788428173792;14107.224102674452;13577.456901723821;13597.932010339884;13618.319084045956;13649.658758531115;13676.794848077088 04:32:37 INFO - PROCESS | 21978 | |3;mootools.html;1559.8674112700423;1587.349186833398;1772.6011647379332;1905.6950887857945;1909.0931807391482;8480.703175388862;9397.342186046979;9518.714438566854;10195.235357348201;10222.948885255573;9491.240700743941;9793.902060979406;9817.969113243114;9907.108360247576;9926.057024582671;2462.8399154054973;2491.4394261291245;2505.2985164153974;2513.0324824942436;2516.2702816183287;2474.381404648838;2549.592065269557;2558.744125587445;2565.6023316385895;2569.4604133132066;2517.244826552036;2521.0798058708533;2535.404180017694;2545.338212064867;2546.2106746908516;2429.6112621980396;2430.647556104364;2443.6823212982376;2456.1649039326717;2463.5442443147986;2320.559093772195;2324.523472688095;2325.720913490375;2347.119830063726;2350.3536527454917;9772;9849.655262065793;9873.259505537042;9880.209583233323;9905.059019393146;5485.204645326406;5604.439556044404;5785.82642520725;5870.6477611343025;5872.5889187756875;3527.5590551181103;3600.6219346968714;3679.319325924686;3679.4296883983025;3681.3557627415094;1181.934993575353;1196.174639498743;1207.8127890177036;1209.419478650244;1237.3256575166556;13988.090774099652;14028.789568156486;14069.788953165711;14084.436622535086;14107.78838317426;5112.616553758483;5135.306733590992;5175.378954525406;5195.246689230041;5263.526282634582;11892.167548271711;11905.345206013752;11938.940305298418;11959.701007474709;11982.520699171935;5626.324841019104;5657.123145912308;5658.688772117573;5659.292588426447;5667.461591148916;4330.588594083557;5054.671446355975;5201.375834899836;5334.759935802898;5347.812826551052;4278.358246263023;4340.47914250292;4366.323219900921;4393.055493068941;4399.758013309235;1412.053923871009;1423.7508436023654;1428.6356978970296;1428.985710142906;1432;907.382979573883;911.3119594705954;945.0785484152896;953.1612181280428;1012.1801340913884;5928.644281343133;6168.19813424252;6227.564070515021;6235.127082208494;6334.493240540745;964.80932582706;1016.5832008876325;1021.1626466297565;1042.103790739963;1043.9739006524746;3691.8154092295276;3777.7355585109326;3806.847726090981;3825.84696612138;3830.19565891166;12124.27254364741;12311.815322770166;12425.37873106341;12461.12772105962;12525;11728.120390970711;12118.81821772674;12131.21147125434;12138.757224855453;12247.755044899051;8819.559022048872;9188.173064424234;9212.769680757901;9226.40028398152;9228.26173906086;5997.460228579449;6169.9691501544;6215.409536094064;6324.525660575383;6654.767083152066;10814;11100.444977751242;11184.608538701106;11296.6046188383;11406.942965285121;11407.714807129556;11660.591879284184;11798.52805887755;11854.644360669194;11955.462004209658;8521.701740439055;8755.299576033774;8826.161514656098;8829.426087304304;8924.062973387961;9801.950990245003;9834.75413114678;9846.261530385107;9870.802583948425;9931.453770042717;8467.915320846712;8692.52191129494;8851.911480885366;8879.156480134377;8979.326550508607;8227.300679442074;8367.62345694433;8581.95709021451;8643.438176518757;8806.91193088061;7420.220876807857;7448.92551074504;7486;7503.624818758931;7531.397488201041;5064.721440320818;5145.948540514697;5194.610404219774;5205.739713014258;5295.7087360195555;5212.087884620252;5257.316548848626;5263.842084737464;5312.070387682217;5346.064438723286 04:32:37 INFO - PROCESS | 21978 | |4;prototype.html;334.1579220364681;337.4331123712163;339.98980030599057;348.2599476113259;348.98619510322516;5668.603197776158;5761;5779.150671785031;5790.68151251681;5831.183634291203;5632.887342253152;5633.6338138021;5667;5693.544516438686;5717.571182161334;4068.3897415387783;4168.812403441845;4382.028087360684;4397.560243975593;4404.7357158570585;4394.1651086293505;4417.381566580665;4433.600975912167;4443.800173953031;4450.399196108532;4411;4420.983173870012;4428.3800267962515;4435.46774387074;4453.710508816933;4247.490301163864;4395.582429663672;4411.1618792429335;4441.888952776174;4458.331250312447;3876.4379165021196;3888.1446081861945;3901.9609803902167;3905.902352441183;3911.5306163260307;5452.91820622691;5461.590380721422;5479.863003424906;5497.670139791585;5507.146392309159;5014.623903207274;5070.3915530136255;5077.086124497589;5121.948780512184;5128;5905.350411454737;5915.645061296293;5922.31893332268;5943.940560594425;5972.492338151219;4300.462442194726;4316.503602085769;4319.438472998521;4344.543822898581;4349.3475978603465;6090.512758979271;6092.817215483498;6170.691465426711;6195.783147589857;6247.562670613059;4297.140571885635;4301.440812694393;4303.612674859215;4309.439772829513;4332.545082766327;4377.737335759864;4390.638901940409;4391.736495810262;4398.428204333416;4400.757958312323;4900.485449027872;5006.822032415911;5013.245364122601;5066.544011039025;5079.238114282887;5959.433853783884;5971;5974.163617093611;5975.52195824333;5987.251593550806;1477.566760242563;1485.413261761598;1487.5611694550134;1489.121418363171;1489.3000289863746;914.4545717737003;948.772294649293;950.0119875329718;960.5533426956499;961.4423634292094;5241.580673546107;5243.528082472596;5256.237845512379;5276.81531146408;5282.784959459269;5465.699386533699;5524.226608274845;5568.9443105569235;5576.665400076008;5578.624931916213;4893.412790465096;5166.870828229325;5207.062728708869;5279.815206467755;5292.4707529247535;2928.2240206345336;2948.189247956786;2950.734433900959;2957.4030023787345;2962.289050627877;5735.738137609719;5736.368999410061;5740.311162660508;5751.769929202785;5764.308283006066;5184.11869982104;5569.888602228014;5587.966226248076;5620.494155526022;5652.74562644682;5649.661020338793;5659.462351076723;5662.716864156858;5745.482906538348;5781.4218578141845;5184.403793563638;5496.697681627389;5505.944940550704;5545.694986775605;5554.416786237387;5396.568274537949;5402.432744561922;5405.540479082087;5447.509724124848;5920.407959204045;6376.947803612352;6451.612903225829;6463.289038205699;6483.384078512534;6485.189351331083;4378.75916824565;4436.3123715824095;4459.531749166421;4469;4489.461264648263;6151.661658608819;6218.191635087591;6245.313015568375;6282.465990390685;6306.432421082125;6027.30685971119;6093.6039157454625;6101.528880803282;6102.908456373247;6129;6036.9698151508965;6043.7884674036195;6063.575549711478;6122.693865306628;6161;5969.701514924323;5995.550333724901;6002.279726432856;6034.849128771816;6044.395560443921;6046.667433291212;6098.451139397298;6124.866899623584;6172.197614310111;6185.907211391923;5780.826575202751;5939.940600594112;5974.22335096452;5977.760889564369;5983.55123365758 04:32:37 INFO - PROCESS | 21978 | |5;yui.html;695.1537569044339;706.5372181221302;732.4653003307587;734.1850545894057;801.5431204213601;14263.215523146222;15396.61508462289;15409.306581203844;15439.382424703026;15449.45926892559;14932.029418087817;15093.924530377333;15111.471098511554;15121.168335741557;16677.749833752503;867.8698195270697;872.0146234754718;872.733816186063;873.0658195730571;873.5763154869883;859.7592674051276;863.8920134983127;869.8477766390888;870.1168314161132;870.1516021878649;909.5088652127843;914.0356923445762;915.327234482658;915.7069737683944;917.3945196170529;904.3714618340223;904.900460949295;908.5593487158723;908.7773495493581;911.6444586611227;664.0636702249852;666.0708311904865;667.6394746836702;669.5413641655482;670.6479098473292;15511.844881551153;15607.687846243012;15613.453529126426;15623.453179138789;15650.295736691876;14773.852261477356;15266.290944027884;15327.770083448757;15466.072035677895;15585.688286234325;13559.932200339033;13645.522406715718;13692.863071369258;13712.24582647954;13816;4591.701539399962;4668.486466488684;4674.158651442739;4683.180443422421;4698.906021879578;82731;82851.5857420709;82911;84201.57899210526;84722;11959.583893285517;12362.567310144103;12394.132410731343;12420.130590858735;12469.127161098817;21104;21119.155233790785;21135.894320528605;21151;21153.576928461345;8259.42184047111;8369.079401265855;8381.16188381157;8518.105598912149;8588.184122508352;4625.606823419979;4687.882802929954;4779.641526885497;4818.060478206716;4827.975860120747;3476.269983303484;3566.3402270580027;3571.339302229096;3574.3387473317;3575.481555174485;629.8205011571772;641.7785863876956;642.9174740398432;647.789468422755;656.8784774816675;634.4511997122456;652.7160685101995;657.2080642825384;706.593708617547;724.9383802376751;8729.432586881832;9043.68347107848;9161.175494205554;9243.306751993627;9326.207272381924;637.4167636612448;695.290803380549;706.2266817834463;716.2729829223342;723.869703453373;4448.955510444919;4537.568930951555;4553.476350219701;4563.452385713736;4642.326862604903;75842;76067;118177;118580;122895;100168;101117;102570.48714756378;102750.48624756829;103071.48464257631;86934;87083;88808;89361;91409.54295228481;8746.51894145828;8772.91227087721;8857.557122143997;8919.955400222958;8940.15068568485;54824.725876370365;55528;55742;56071.43928560662;56769.71615142063;72809;76332;76831.61584192043;76970.23029769855;76972.61513692395;9979.750506237402;10172.745681358025;10668.30656007357;10683.89316106829;10759.3544387337;12580.622581322576;12637.2417654941;12672.493100275886;12715.80926286088;13298.069135160446;11269.830952535882;11459.942700286778;11505.137114716263;11706.063514918616;11730.296182228753;11445.599404020819;11561.710957226136;11877.287362758263;11928.1053920958;12156.331401772988;10848.945755271174;11039;11302.717432064264;11504.482298296429;11745.882541174478;9210.710500530065;9345;9400.717978460658;9410.670626528039;9566.473843938651;9512.95243523778;9623.518824058629;9631.325807193709;9688.176504997155;9693.273004524548 04:32:37 INFO - PROCESS | 21978 | __end_tp_report 04:32:37 INFO - PROCESS | 21978 | __start_cc_report 04:32:37 INFO - PROCESS | 21978 | _x_x_mozilla_cycle_collect,330 04:32:37 INFO - PROCESS | 21978 | __end_cc_report 04:32:37 INFO - PROCESS | 21978 | __startTimestamp1472383957130__endTimestamp 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | ------- Summary: start ------- 04:32:37 INFO - PROCESS | 21978 | Number of tests: 6 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | [#0] dojo.html Cycles:165 Average:5646.66 Median:5886.09 stddev:627.82 (10.7%) stddev-sans-first:603.52 04:32:37 INFO - PROCESS | 21978 | Values: 3357.7 3384.5 3410.1 3419.0 3429.8 5622.1 5628.9 5652.2 5693.6 5696.5 5656.7 5736.7 5740.0 5749.1 5753.2 5123.9 5159.3 5201.2 5247.3 5254.5 5068.5 5077.4 5233.8 5240.8 5245.3 5055.5 5096.0 5110.9 5133.6 5173.9 5108.4 5166.1 5171.2 5179.1 5197.7 4985.7 5012.5 5081.1 5091.6 5104.3 5419.3 5434.4 5492.3 5494.6 5517.7 5955.1 6000.5 6011.5 6014.4 6015.3 5975.2 6061.6 6061.8 6067.5 6068.9 5653.5 5696.1 5698.0 5698.6 5733.2 6199.4 6225.5 6234.0 6248.3 6254.8 5775.8 5783.1 5840.9 5960.1 5961.4 6023.8 6037.0 6051.8 6053.8 6062.4 5952.7 5976.3 6002.9 6012.0 6027.6 5923.3 5990.5 6029.0 6036.9 6062.3 4678.2 4689.6 4699.1 4705.5 4742.2 4170.2 4184.2 4193.0 4207.6 4256.2 5708.1 5762.2 5773.0 5819.9 5837.0 6046.7 6096.5 6133.5 6160.9 6167.8 5714.5 5848.1 5858.7 5870.1 5874.0 5224.9 5256.2 5263.0 5267.4 5281.4 6317.4 6361.2 6365.1 6369.7 6381.3 6005.8 6050.3 6148.2 6159.4 6171.2 6246.0 6347.1 6370.5 6376.4 6378.3 5937.9 5962.7 5969.4 5971.3 5992.8 6040.2 6101.9 6119.0 6137.4 6139.4 5931.8 5966.5 5968.6 5987.2 5990.1 5927.9 5987.7 5995.8 6002.9 6021.9 5731.7 5788.5 5820.4 5886.1 5920.7 6026.7 6042.6 6054.0 6069.8 6074.1 5631.3 5914.1 5928.9 5930.6 5943.7 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | [#1] ext.html Cycles:180 Average:64419.53 Median:24276.88 stddev:138975.98 (572.5%) stddev-sans-first:139283.19 04:32:37 INFO - PROCESS | 21978 | Values: 581.6 633.1 643.4 659.4 675.2 41885.0 45318.8 45620.8 45992.0 46036.3 46195.5 47200.0 47279.5 47284.8 47357.0 8865.6 9019.1 9029.7 9030.4 9044.7 8927.5 9016.0 9016.5 9016.7 9047.8 8993.9 9003.0 9006.2 9068.3 9087.5 8917.6 8974.6 8985.9 9001.4 9024.6 8854.2 8915.3 8940.7 8950.2 8977.1 42748.8 42867.6 42928.1 42985.4 43077.8 3770.0 3958.7 3990.3 4270.2 4330.7 34004.8 34376.0 34461.1 35098.8 36318.5 4011.8 4092.6 4095.0 4119.9 4170.2 245778.0 247053.0 247746.0 247824.0 248546.0 38008.2 39015.6 39240.2 62057.7 62394.4 40452.4 40520.8 40639.2 40646.0 40744.2 15594.8 15619.2 15673.8 15674.4 15805.8 14604.1 14681.8 14699.0 14713.9 14741.1 9339.0 9385.5 9433.1 9436.6 9446.1 3621.4 3623.0 3634.0 3643.9 3709.5 1010.3 1102.2 1118.5 1121.6 1174.8 32950.8 33495.5 33563.0 33760.3 33808.5 1134.8 1162.9 1199.5 1222.8 1274.0 17438.0 17497.7 17598.0 17611.9 17823.3 575160.0 614809.0 623946.0 626759.0 876853.0 59998.1 60338.7 60370.4 60379.0 60389.7 1505.8 1508.2 1511.9 1520.5 1555.0 30715.5 30969.8 31511.5 31643.2 32555.8 51330.2 59879.7 61502.0 61583.7 66442.3 536845.0 537230.0 541758.0 542761.0 542811.0 47965.8 48366.5 48495.5 48909.3 49003.3 53202.7 53638.0 53689.7 54769.0 55095.4 42772.4 43033.0 44223.1 44831.8 45613.5 44508.3 44528.3 44591.6 44671.8 45568.0 44440.8 44641.0 44710.3 45830.0 45831.5 37822.4 38286.6 38959.6 39278.2 39550.8 29546.3 29660.9 30165.8 30260.4 30343.8 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | [#2] jquery.html Cycles:180 Average:30214.45 Median:21663.33 stddev:85924.90 (396.6%) stddev-sans-first:86136.83 04:32:37 INFO - PROCESS | 21978 | Values: 428.7 436.3 438.9 441.5 448.2 18666.2 20006.7 20363.5 21479.4 21494.9 19851.5 20046.5 20079.8 20712.0 20793.3 5871.5 5946.9 5999.6 6076.0 6089.2 5770.1 5933.5 5977.8 5977.9 5988.1 5905.8 5926.1 5928.6 5932.2 5954.0 5667.4 5816.2 5860.8 5865.9 5894.1 5276.4 5286.7 5298.3 5315.9 5322.0 21206.8 22408.9 24149.3 24258.9 24748.0 2365.3 2375.0 2542.4 2671.8 2829.3 10358.9 10485.5 10618.7 10626.9 10772.4 1984.8 1989.3 2002.8 2009.2 2034.4 54362.0 75475.0 90419.5 91117.0 91795.0 10815.2 11190.6 11221.0 11272.0 11325.7 15381.9 15453.9 15454.8 15521.4 15559.7 8272.3 8473.3 8558.4 8578.5 8594.7 7976.4 8085.2 8172.8 8243.7 8311.7 4610.3 4633.6 4666.3 4686.4 4689.6 1838.4 1892.3 1899.8 1919.1 1934.6 1049.4 1073.2 1088.2 1116.1 1116.3 17495.7 20272.2 20321.0 20325.6 20411.8 1046.9 1049.5 1069.3 1070.3 1080.6 10577.6 11380.9 11389.7 11466.7 11469.3 495663.0 505233.0 507425.0 527383.0 564732.0 97749.5 98712.0 100688.0 101092.0 101383.0 1078.5 1102.6 1154.4 1172.7 1176.8 17899.4 17917.7 18042.5 18152.5 18287.5 41939.6 42701.4 42898.0 43473.1 43777.3 56132.7 57330.0 59025.7 65086.3 66259.0 7793.2 8146.7 8150.3 8217.0 9160.0 9219.9 9292.3 9658.5 9732.6 9817.3 8633.2 8655.3 8974.0 9058.1 9130.5 8594.7 8966.9 9001.1 9016.6 9306.3 9120.5 9157.6 9186.3 9274.7 9378.8 13516.5 14069.2 14094.2 14104.8 14107.2 13577.5 13597.9 13618.3 13649.7 13676.8 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | [#3] mootools.html Cycles:180 Average:6390.73 Median:4379.69 stddev:3789.40 (86.5%) stddev-sans-first:3782.65 04:32:37 INFO - PROCESS | 21978 | Values: 1559.9 1587.3 1772.6 1905.7 1909.1 8480.7 9397.3 9518.7 10195.2 10222.9 9491.2 9793.9 9818.0 9907.1 9926.1 2462.8 2491.4 2505.3 2513.0 2516.3 2474.4 2549.6 2558.7 2565.6 2569.5 2517.2 2521.1 2535.4 2545.3 2546.2 2429.6 2430.6 2443.7 2456.2 2463.5 2320.6 2324.5 2325.7 2347.1 2350.4 9772.0 9849.7 9873.3 9880.2 9905.1 5485.2 5604.4 5785.8 5870.6 5872.6 3527.6 3600.6 3679.3 3679.4 3681.4 1181.9 1196.2 1207.8 1209.4 1237.3 13988.1 14028.8 14069.8 14084.4 14107.8 5112.6 5135.3 5175.4 5195.2 5263.5 11892.2 11905.3 11938.9 11959.7 11982.5 5626.3 5657.1 5658.7 5659.3 5667.5 4330.6 5054.7 5201.4 5334.8 5347.8 4278.4 4340.5 4366.3 4393.1 4399.8 1412.1 1423.8 1428.6 1429.0 1432.0 907.4 911.3 945.1 953.2 1012.2 5928.6 6168.2 6227.6 6235.1 6334.5 964.8 1016.6 1021.2 1042.1 1044.0 3691.8 3777.7 3806.8 3825.8 3830.2 12124.3 12311.8 12425.4 12461.1 12525.0 11728.1 12118.8 12131.2 12138.8 12247.8 8819.6 9188.2 9212.8 9226.4 9228.3 5997.5 6170.0 6215.4 6324.5 6654.8 10814.0 11100.4 11184.6 11296.6 11406.9 11407.7 11660.6 11798.5 11854.6 11955.5 8521.7 8755.3 8826.2 8829.4 8924.1 9802.0 9834.8 9846.3 9870.8 9931.5 8467.9 8692.5 8851.9 8879.2 8979.3 8227.3 8367.6 8582.0 8643.4 8806.9 7420.2 7448.9 7486.0 7503.6 7531.4 5064.7 5145.9 5194.6 5205.7 5295.7 5212.1 5257.3 5263.8 5312.1 5346.1 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | [#4] prototype.html Cycles:180 Average:4904.15 Median:5497.18 stddev:1444.23 (26.3%) stddev-sans-first:1406.96 04:32:37 INFO - PROCESS | 21978 | Values: 334.2 337.4 340.0 348.3 349.0 5668.6 5761.0 5779.2 5790.7 5831.2 5632.9 5633.6 5667.0 5693.5 5717.6 4068.4 4168.8 4382.0 4397.6 4404.7 4394.2 4417.4 4433.6 4443.8 4450.4 4411.0 4421.0 4428.4 4435.5 4453.7 4247.5 4395.6 4411.2 4441.9 4458.3 3876.4 3888.1 3902.0 3905.9 3911.5 5452.9 5461.6 5479.9 5497.7 5507.1 5014.6 5070.4 5077.1 5121.9 5128.0 5905.4 5915.6 5922.3 5943.9 5972.5 4300.5 4316.5 4319.4 4344.5 4349.3 6090.5 6092.8 6170.7 6195.8 6247.6 4297.1 4301.4 4303.6 4309.4 4332.5 4377.7 4390.6 4391.7 4398.4 4400.8 4900.5 5006.8 5013.2 5066.5 5079.2 5959.4 5971.0 5974.2 5975.5 5987.3 1477.6 1485.4 1487.6 1489.1 1489.3 914.5 948.8 950.0 960.6 961.4 5241.6 5243.5 5256.2 5276.8 5282.8 5465.7 5524.2 5568.9 5576.7 5578.6 4893.4 5166.9 5207.1 5279.8 5292.5 2928.2 2948.2 2950.7 2957.4 2962.3 5735.7 5736.4 5740.3 5751.8 5764.3 5184.1 5569.9 5588.0 5620.5 5652.7 5649.7 5659.5 5662.7 5745.5 5781.4 5184.4 5496.7 5505.9 5545.7 5554.4 5396.6 5402.4 5405.5 5447.5 5920.4 6376.9 6451.6 6463.3 6483.4 6485.2 4378.8 4436.3 4459.5 4469.0 4489.5 6151.7 6218.2 6245.3 6282.5 6306.4 6027.3 6093.6 6101.5 6102.9 6129.0 6037.0 6043.8 6063.6 6122.7 6161.0 5969.7 5995.6 6002.3 6034.8 6044.4 6046.7 6098.5 6124.9 6172.2 6185.9 5780.8 5939.9 5974.2 5977.8 5983.6 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - PROCESS | 21978 | [#5] yui.html Cycles:180 Average:20681.99 Median:56420.58 stddev:30157.47 (53.5%) stddev-sans-first:30204.73 04:32:37 INFO - PROCESS | 21978 | Values: 695.2 706.5 732.5 734.2 801.5 14263.2 15396.6 15409.3 15439.4 15449.5 14932.0 15093.9 15111.5 15121.2 16677.7 867.9 872.0 872.7 873.1 873.6 859.8 863.9 869.8 870.1 870.2 909.5 914.0 915.3 915.7 917.4 904.4 904.9 908.6 908.8 911.6 664.1 666.1 667.6 669.5 670.6 15511.8 15607.7 15613.5 15623.5 15650.3 14773.9 15266.3 15327.8 15466.1 15585.7 13559.9 13645.5 13692.9 13712.2 13816.0 4591.7 4668.5 4674.2 4683.2 4698.9 82731.0 82851.6 82911.0 84201.6 84722.0 11959.6 12362.6 12394.1 12420.1 12469.1 21104.0 21119.2 21135.9 21151.0 21153.6 8259.4 8369.1 8381.2 8518.1 8588.2 4625.6 4687.9 4779.6 4818.1 4828.0 3476.3 3566.3 3571.3 3574.3 3575.5 629.8 641.8 642.9 647.8 656.9 634.5 652.7 657.2 706.6 724.9 8729.4 9043.7 9161.2 9243.3 9326.2 637.4 695.3 706.2 716.3 723.9 4449.0 4537.6 4553.5 4563.5 4642.3 75842.0 76067.0 118177.0 118580.0 122895.0 100168.0 101117.0 102570.5 102750.5 103071.5 86934.0 87083.0 88808.0 89361.0 91409.5 8746.5 8772.9 8857.6 8920.0 8940.2 54824.7 55528.0 55742.0 56071.4 56769.7 72809.0 76332.0 76831.6 76970.2 76972.6 9979.8 10172.7 10668.3 10683.9 10759.4 12580.6 12637.2 12672.5 12715.8 13298.1 11269.8 11459.9 11505.1 11706.1 11730.3 11445.6 11561.7 11877.3 11928.1 12156.3 10848.9 11039.0 11302.7 11504.5 11745.9 9210.7 9345.0 9400.7 9410.7 9566.5 9513.0 9623.5 9631.3 9688.2 9693.3 04:32:37 INFO - PROCESS | 21978 | -------- Summary: end -------- 04:32:37 INFO - PROCESS | 21978 | 04:32:37 INFO - TEST-INFO | 21978: exit 0 04:32:37 INFO - TEST-OK | dromaeo_css | took 1109438ms 04:32:37 INFO - TEST-START | kraken 04:32:37 INFO - operating with platform_type : linux_ 04:32:37 INFO - Initialising browser for kraken test... 04:32:37 INFO - TEST-INFO | started process 22227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytfz80/profile http://localhost:55306/getInfo.html) 04:32:42 INFO - PROCESS | 22227 | __metrics Screen width/height:1600/1200 04:32:42 INFO - PROCESS | 22227 | colorDepth:24 04:32:42 INFO - PROCESS | 22227 | Browser inner width/height: 1024/697 04:32:42 INFO - PROCESS | 22227 | __metrics 04:32:42 ERROR - PROCESS | 22227 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:32:43 INFO - TEST-INFO | 22227: exit 0 04:32:43 INFO - Browser initialized. 04:32:43 INFO - Running cycle 1/1 for kraken test... 04:32:43 INFO - TEST-INFO | started process 22354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytfz80/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:55 INFO - PROCESS | 22354 | RSS: Main: 152551424 04:32:55 INFO - PROCESS | 22354 | 04:32:57 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55306/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:58 INFO - PROCESS | 22354 | RSS: Main: 157736960 04:32:58 INFO - PROCESS | 22354 | 04:33:01 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55306/tests/kraken/driver.html?testName=audio-dft) 04:33:01 INFO - PROCESS | 22354 | RSS: Main: 156635136 04:33:01 INFO - PROCESS | 22354 | 04:33:04 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55306/tests/kraken/driver.html?testName=audio-fft) 04:33:05 INFO - PROCESS | 22354 | RSS: Main: 157253632 04:33:05 INFO - PROCESS | 22354 | 04:33:07 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55306/tests/kraken/driver.html?testName=audio-oscillator) 04:33:08 INFO - PROCESS | 22354 | RSS: Main: 157319168 04:33:08 INFO - PROCESS | 22354 | 04:33:10 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:10 INFO - PROCESS | 22354 | RSS: Main: 157356032 04:33:10 INFO - PROCESS | 22354 | 04:33:13 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55306/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:14 INFO - PROCESS | 22354 | RSS: Main: 157237248 04:33:14 INFO - PROCESS | 22354 | 04:33:17 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55306/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:18 INFO - PROCESS | 22354 | RSS: Main: 157609984 04:33:18 INFO - PROCESS | 22354 | 04:33:21 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55306/tests/kraken/driver.html?testName=json-parse-financial) 04:33:21 INFO - PROCESS | 22354 | RSS: Main: 157409280 04:33:21 INFO - PROCESS | 22354 | 04:33:23 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:24 INFO - PROCESS | 22354 | RSS: Main: 157249536 04:33:24 INFO - PROCESS | 22354 | 04:33:25 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:26 INFO - PROCESS | 22354 | RSS: Main: 157646848 04:33:26 INFO - PROCESS | 22354 | 04:33:28 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:29 INFO - PROCESS | 22354 | RSS: Main: 157949952 04:33:29 INFO - PROCESS | 22354 | 04:33:31 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:32 INFO - PROCESS | 22354 | RSS: Main: 158642176 04:33:32 INFO - PROCESS | 22354 | 04:33:35 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:35 INFO - PROCESS | 22354 | RSS: Main: 157937664 04:33:35 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | Cycle 1(1): loaded http://localhost:55306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55306/tests/kraken/driver.html?testName=ai-astar) 04:33:37 INFO - PROCESS | 22354 | RSS: Main: 158720000 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | __start_tp_report 04:33:37 INFO - PROCESS | 22354 | _x_x_mozilla_page_load 04:33:37 INFO - PROCESS | 22354 | _x_x_mozilla_page_load_details 04:33:37 INFO - PROCESS | 22354 | |i|pagename|runs| 04:33:37 INFO - PROCESS | 22354 | |0;ai-astar;111;106;110;109;113;111;110;111;110;111 04:33:37 INFO - PROCESS | 22354 | |1;audio-beat-detection;153;128;150;177;124;157;162;126;181;125 04:33:37 INFO - PROCESS | 22354 | |2;audio-dft;162;161;162;162;162;162;162;162;161;175 04:33:37 INFO - PROCESS | 22354 | |3;audio-fft;74;82;76;162;83;75;75;75;177;76 04:33:37 INFO - PROCESS | 22354 | |4;audio-oscillator;85;85;142;88;87;85;128;83;85;137 04:33:37 INFO - PROCESS | 22354 | |5;imaging-gaussian-blur;120;117;117;117;117;117;117;117;117;117 04:33:37 INFO - PROCESS | 22354 | |6;imaging-darkroom;147;147;146;146;145;148;146;147;147;146 04:33:37 INFO - PROCESS | 22354 | |7;imaging-desaturate;95;95;95;100;96;96;95;95;95;95 04:33:37 INFO - PROCESS | 22354 | |8;json-parse-financial;52;55;53;53;58;53;53;57;55;54 04:33:37 INFO - PROCESS | 22354 | |9;json-stringify-tinderbox;62;62;61;62;62;61;61;61;61;61 04:33:37 INFO - PROCESS | 22354 | |10;stanford-crypto-aes;76;77;78;76;77;83;82;78;102;77 04:33:37 INFO - PROCESS | 22354 | |11;stanford-crypto-ccm;127;120;135;128;121;125;127;132;124;133 04:33:37 INFO - PROCESS | 22354 | |12;stanford-crypto-pbkdf2;155;155;153;154;150;154;153;153;151;155 04:33:37 INFO - PROCESS | 22354 | |13;stanford-crypto-sha256-iterative;64;67;63;64;66;64;62;63;63;62 04:33:37 INFO - PROCESS | 22354 | __end_tp_report 04:33:37 INFO - PROCESS | 22354 | __start_cc_report 04:33:37 INFO - PROCESS | 22354 | _x_x_mozilla_cycle_collect,840 04:33:37 INFO - PROCESS | 22354 | __end_cc_report 04:33:37 INFO - PROCESS | 22354 | __startTimestamp1472384017523__endTimestamp 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | ------- Summary: start ------- 04:33:37 INFO - PROCESS | 22354 | Number of tests: 14 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 04:33:37 INFO - PROCESS | 22354 | Values: 111.0 106.0 110.0 109.0 113.0 111.0 110.0 111.0 110.0 111.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.00 stddev:21.66 (14.0%) stddev-sans-first:22.91 04:33:37 INFO - PROCESS | 22354 | Values: 153.0 128.0 150.0 177.0 124.0 157.0 162.0 126.0 181.0 125.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.00 stddev:4.20 (2.6%) stddev-sans-first:4.44 04:33:37 INFO - PROCESS | 22354 | Values: 162.0 161.0 162.0 162.0 162.0 162.0 162.0 162.0 161.0 175.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:39.28 (52.0%) stddev-sans-first:40.89 04:33:37 INFO - PROCESS | 22354 | Values: 74.0 82.0 76.0 162.0 83.0 75.0 75.0 75.0 177.0 76.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:85.00 stddev:24.53 (28.9%) stddev-sans-first:25.37 04:33:37 INFO - PROCESS | 22354 | Values: 85.0 85.0 142.0 88.0 87.0 85.0 128.0 83.0 85.0 137.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:0.00 04:33:37 INFO - PROCESS | 22354 | Values: 120.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 04:33:37 INFO - PROCESS | 22354 | Values: 147.0 147.0 146.0 146.0 145.0 148.0 146.0 147.0 147.0 146.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.57 (1.6%) stddev-sans-first:1.64 04:33:37 INFO - PROCESS | 22354 | Values: 95.0 95.0 95.0 100.0 96.0 96.0 95.0 95.0 95.0 95.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.95 (3.6%) stddev-sans-first:1.88 04:33:37 INFO - PROCESS | 22354 | Values: 52.0 55.0 53.0 53.0 58.0 53.0 53.0 57.0 55.0 54.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 04:33:37 INFO - PROCESS | 22354 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:77.50 stddev:7.89 (10.2%) stddev-sans-first:8.19 04:33:37 INFO - PROCESS | 22354 | Values: 76.0 77.0 78.0 76.0 77.0 83.0 82.0 78.0 102.0 77.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:127.50 stddev:4.98 (3.9%) stddev-sans-first:5.29 04:33:37 INFO - PROCESS | 22354 | Values: 127.0 120.0 135.0 128.0 121.0 125.0 127.0 132.0 124.0 133.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:154.00 stddev:1.70 (1.1%) stddev-sans-first:1.69 04:33:37 INFO - PROCESS | 22354 | Values: 155.0 155.0 153.0 154.0 150.0 154.0 153.0 153.0 151.0 155.0 04:33:37 INFO - PROCESS | 22354 | 04:33:37 INFO - PROCESS | 22354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.62 (2.5%) stddev-sans-first:1.72 04:33:37 INFO - PROCESS | 22354 | Values: 64.0 67.0 63.0 64.0 66.0 64.0 62.0 63.0 63.0 62.0 04:33:37 INFO - PROCESS | 22354 | -------- Summary: end -------- 04:33:37 INFO - PROCESS | 22354 | 04:33:38 INFO - TEST-INFO | 22354: exit 0 04:33:38 INFO - TEST-OK | kraken | took 60670ms 04:33:38 INFO - SUITE-END | took 1170s 04:33:38 INFO - Completed test suite (00:19:30) 04:33:38 INFO - javascript benchmark 04:33:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7497.342531428299, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.73138148948, 3384.4754063120195, 3410.1474631342157, 3419.025577710353, 3429.7942123472594, 5622.07235806092, 5628.943710562893, 5652.236948012017, 5693.572982026354, 5696.544276457884, 5656.660600363981, 5736.684482353469, 5739.971300143494, 5749.080147176443, 5753.223314852494, 5123.871903202422, 5159.277701121827, 5201.2458193561915, 5247.291615631898, 5254.500822421864, 5068.46781087986, 5077.390713114413, 5233.816816411427, 5240.816571420001, 5245.291885595453, 5055.494450554952, 5095.9745201273945, 5110.897782044375, 5133.614978876581, 5173.922391164136, 5108.438071812097, 5166.147585648401, 5171.172612382001, 5179.14544100223, 5197.688138711652, 4985.675931064469, 5012.473690262543, 5081.110805609041, 5091.592672586221, 5104.336436263299, 5419.349678038621, 5434.375046869621, 5492.286002819608, 5494.642848214893, 5517.724113794295, 5955.076963070731, 6000.459958603703, 6011.549133814938, 6014.3985601439945, 6015.338312785634, 5975.163477113208, 6061.575689701723, 6061.787837425713, 6067.484263837579, 6068.908966365508, 5653.547716182696, 5696.145578163268, 5698.031334673115, 5698.629589076738, 5733.197352370671, 6199.442050215412, 6225.470834978987, 6234.0337247726675, 6248.250209974832, 6254.843628909313, 5775.797847075332, 5783.103618939072, 5840.883182336414, 5960.135780311831, 5961.433663801932, 6023.789167379208, 6037.034074548139, 6051.818445446644, 6053.848653783691, 6062.363451837582, 5952.672603006876, 5976.312724036705, 6002.879942401215, 6012.038073908154, 6027.60820546663, 5923.318818335861, 5990.490808281258, 6028.969855150696, 6036.939630603725, 6062.302835173923, 4678.1813182692895, 4689.62483001359, 4699.060187962421, 4705.482396936334, 4742.19382704941, 4170.228507726019, 4184.184084103571, 4193.0, 4207.621314081747, 4256.233877901946, 5708.086706127, 5762.193292938992, 5773.04744717117, 5819.94180058194, 5837.0, 6046.7278972445465, 6096.481799047131, 6133.509319254449, 6160.9383906161265, 6167.784127555514, 5714.485696287354, 5848.064309710426, 5858.677772722456, 5870.090136028923, 5874.030784920526, 5224.869378265497, 5256.237845512455, 5262.97368513155, 5267.446918073624, 5281.445448227958, 6317.431431171217, 6361.2048493938255, 6365.108884756138, 6369.681515924185, 6381.266154392211, 6005.819825405245, 6050.30421501533, 6148.200733904474, 6159.353267906805, 6171.197744293213, 6246.031865060922, 6347.111404403295, 6370.490360771035, 6376.426121649074, 6378.298387177314, 5937.910931335947, 5962.70186490665, 5969.403059694169, 5971.313298970674, 5992.820215393545, 6040.244969378828, 6101.908471372844, 6119.020956646915, 6137.3862613738265, 6139.3730661373875, 5931.792387266598, 5966.522678185822, 5968.612040217372, 5987.221661184019, 5990.101484777319, 5927.911081333869, 5987.670678112746, 5995.790147344822, 6002.879942401215, 6021.909671354845, 5731.656100633975, 5788.507976821849, 5820.417958204146, 5886.087656413263, 5920.674362910081, 6026.668533230714, 6042.577019608585, 6053.969730151321, 6069.817905462844, 6074.088886667036, 5631.267935168402, 5914.112883067574, 5928.9407105928385, 5930.614510056833, 5943.702814859326], "value": 5605.892357103042, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.5986968991396, 633.1168020611248, 643.3502162815556, 659.3966520633619, 675.1998881325626, 41885.0, 45318.773406133005, 45620.771896140555, 45992.0, 46036.309455358154, 46195.53804461954, 47200.0, 47279.52720472803, 47284.76357618216, 47357.0, 8865.556722163883, 9019.143181397756, 9029.683961061364, 9030.413023153507, 9044.728658140266, 8927.46435213886, 9016.0, 9016.504092274956, 9016.68441604544, 9047.819043619123, 8993.865092023625, 9002.954985225097, 9006.23447007002, 9068.319876009293, 9087.500187489686, 8917.554122293892, 8974.551272436418, 8985.865212021825, 9001.414908030956, 9024.593893274818, 8854.247388971946, 8915.28677705782, 8940.68707595231, 8950.194482496541, 8977.057408972028, 42748.78625606852, 42867.57132428698, 42928.14143717139, 42985.35521967173, 43077.78461107674, 3769.962300377016, 3958.6635136013474, 3990.2817492851277, 4270.208653417263, 4330.653547716175, 34004.82997585021, 34376.0, 34461.138471538165, 35098.82450587731, 36318.45522317167, 4011.805859204202, 4092.611201935841, 4094.979525102385, 4119.8970025749295, 4170.16596680665, 245778.0, 247053.0, 247745.9999999982, 247824.0, 248546.0, 38008.23983520314, 39015.609843901766, 39240.215195696495, 62057.68971155115, 62394.376056239766, 40452.39321410181, 40520.79739601283, 40639.18721625551, 40646.0, 40744.18511629751, 15594.766078508832, 15619.21903904823, 15673.764893526606, 15674.373025079098, 15805.841941580667, 14604.12375257488, 14681.77977330341, 14699.0, 14713.852861471463, 14741.11553306805, 9338.953305233566, 9385.483798391155, 9433.103855133751, 9436.575354109082, 9446.055394460636, 3621.420572708407, 3622.9637703623152, 3633.9636603634153, 3643.9453408198897, 3709.4806727058235, 1010.2978429991233, 1102.1513434655271, 1118.4687273545, 1121.5738019552518, 1174.770919670673, 32950.8352458241, 33495.49756753602, 33563.0, 33760.32479350399, 33808.492872606934, 1134.773045390925, 1162.9418529073682, 1199.5126043705743, 1222.7921253386946, 1274.0, 17438.0, 17497.650046998988, 17598.032108233914, 17611.911940440215, 17823.287068517373, 575160.0, 614809.0, 623946.0, 626759.0, 876853.0, 59998.100028499604, 60338.69830650819, 60370.39629603648, 60379.0, 60389.69805150946, 1505.8042454481067, 1508.178042966564, 1511.871490923262, 1520.4602366160075, 1555.0358777557985, 30715.539266910568, 30969.8451507741, 31511.527327089654, 31643.20891977719, 32555.83722081469, 51330.23004654858, 59879.70060149671, 61502.0, 61583.6920815393, 66442.33557664361, 536845.0, 537230.0, 541758.0, 542761.0, 542811.0, 47965.760171200316, 48366.516334836204, 48495.5150448491, 48909.2663610039, 49003.264951026475, 53202.73398632982, 53638.0, 53689.731551341996, 54769.0, 55095.449045509034, 42772.35841462318, 43033.0, 44223.11553768971, 44831.77584112059, 45613.54386456093, 44508.332375015045, 44528.332075018254, 44591.55408445874, 44671.77664111659, 45568.0, 44440.7777961121, 44641.0, 44710.3293450605, 45830.0, 45831.54168458273, 37822.43266350952, 38286.61713382942, 38959.6104038956, 39278.2144357117, 39550.80224598858, 29546.261343466584, 29660.851695742247, 30165.849170754005, 30260.394792104475, 30343.848280758455], "value": 20210.22612381486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.665640800176, 436.28013777267483, 438.8880835386976, 441.4857040351593, 448.1686471595193, 18666.160022798973, 20006.699899501502, 20363.49091272719, 21479.355619331407, 21494.89252553735, 19851.50371240716, 20046.49883752907, 20079.799202007976, 20712.0, 20793.272235471763, 5871.471567558919, 5946.910796338058, 5999.580029397944, 6076.0, 6089.208402907616, 5770.105633626795, 5933.495652869511, 5977.7608895644125, 5977.88044239115, 5988.1317209004665, 5905.822825315247, 5926.140709597106, 5928.614640048383, 5932.199153114339, 5954.0, 5667.4049224831415, 5816.1566572846705, 5860.824175274749, 5865.85335366615, 5894.115882617599, 5276.366835979668, 5286.709230992294, 5298.258243845865, 5315.893682126336, 5321.973390133025, 21206.787932120635, 22408.887955560116, 24149.275521734202, 24258.878705606534, 24748.0, 2365.3258821235863, 2374.976250237493, 2542.4025354041787, 2671.7595416412614, 2829.2926768307925, 10358.948205259001, 10485.528151233213, 10618.681439556825, 10626.893731062668, 10772.35365878042, 1984.8412127029803, 1989.293800700745, 2002.8097330753556, 2009.2063634864294, 2034.440528854562, 54362.0, 75475.0, 90419.54790226073, 91117.0, 91795.0, 10815.242932994772, 11190.608328708457, 11221.0, 11272.0, 11325.660230193107, 15381.923090384476, 15453.922730386501, 15454.768178477332, 15521.379144834305, 15559.688806223812, 8272.296854767292, 8473.279771219391, 8558.400911936105, 8578.485290882567, 8594.699185528476, 7976.364845206719, 8085.231902969209, 8172.7956801080445, 8243.711470098518, 8311.667533298722, 4610.331501932201, 4633.606143477842, 4666.346711460398, 4686.36734040907, 4689.577937985598, 1838.4208974173093, 1892.2903911033363, 1899.819517145869, 1919.0980239287512, 1934.6034063017048, 1049.3598904668147, 1073.1843798712878, 1088.1675518228562, 1116.1182665694173, 1116.3246236027248, 17495.65008699819, 20272.189112435633, 20321.0, 20325.593488130155, 20411.795882041286, 1046.895310468947, 1049.464772965793, 1069.315637991686, 1070.250824422907, 1080.6379862746069, 10577.62978295756, 11380.886191138148, 11389.715257118472, 11466.656000320003, 11469.25449845774, 495663.0, 505233.0, 507425.0, 527383.0, 564732.0, 97749.5112524447, 98712.0, 100688.0, 101092.0, 101383.0, 1078.541619811577, 1102.5699977008974, 1154.4285578638628, 1172.6892373521023, 1176.823476478535, 17899.37352192667, 17917.731234031762, 18042.548936276173, 18152.45542633723, 18287.542811429288, 41939.580604193565, 42701.35947960845, 42898.0, 43473.130537388446, 43777.343339850566, 56132.71933640305, 57330.0, 59025.70487147537, 65086.349136508026, 66259.0, 7793.181715919747, 8146.674133034612, 8150.26647601695, 8217.0, 9160.0, 9219.861702074608, 9292.349535532718, 9658.517074146404, 9732.610695572097, 9817.312788104764, 8633.179847914438, 8655.29227796553, 8974.0, 9058.094190581152, 9130.508626976974, 8594.65621375138, 8966.910330896868, 9001.144891235323, 9016.639334426549, 9306.255499560155, 9120.498372589305, 9157.587908544265, 9186.265098792213, 9274.721758347261, 9378.765530861783, 13516.5269215577, 14069.155850648995, 14094.154350738989, 14104.788428173792, 14107.224102674452, 13577.456901723821, 13597.932010339884, 13618.319084045956, 13649.658758531115, 13676.794848077088], "value": 9385.689225446215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.8674112700423, 1587.349186833398, 1772.6011647379332, 1905.6950887857945, 1909.0931807391482, 8480.703175388862, 9397.342186046979, 9518.714438566854, 10195.235357348201, 10222.948885255573, 9491.240700743941, 9793.902060979406, 9817.969113243114, 9907.108360247576, 9926.057024582671, 2462.8399154054973, 2491.4394261291245, 2505.2985164153974, 2513.0324824942436, 2516.2702816183287, 2474.381404648838, 2549.592065269557, 2558.744125587445, 2565.6023316385895, 2569.4604133132066, 2517.244826552036, 2521.0798058708533, 2535.404180017694, 2545.338212064867, 2546.2106746908516, 2429.6112621980396, 2430.647556104364, 2443.6823212982376, 2456.1649039326717, 2463.5442443147986, 2320.559093772195, 2324.523472688095, 2325.720913490375, 2347.119830063726, 2350.3536527454917, 9772.0, 9849.655262065793, 9873.259505537042, 9880.209583233323, 9905.059019393146, 5485.204645326406, 5604.439556044404, 5785.82642520725, 5870.6477611343025, 5872.5889187756875, 3527.5590551181103, 3600.6219346968714, 3679.319325924686, 3679.4296883983025, 3681.3557627415094, 1181.934993575353, 1196.174639498743, 1207.8127890177036, 1209.419478650244, 1237.3256575166556, 13988.090774099652, 14028.789568156486, 14069.788953165711, 14084.436622535086, 14107.78838317426, 5112.616553758483, 5135.306733590992, 5175.378954525406, 5195.246689230041, 5263.526282634582, 11892.167548271711, 11905.345206013752, 11938.940305298418, 11959.701007474709, 11982.520699171935, 5626.324841019104, 5657.123145912308, 5658.688772117573, 5659.292588426447, 5667.461591148916, 4330.588594083557, 5054.671446355975, 5201.375834899836, 5334.759935802898, 5347.812826551052, 4278.358246263023, 4340.47914250292, 4366.323219900921, 4393.055493068941, 4399.758013309235, 1412.053923871009, 1423.7508436023654, 1428.6356978970296, 1428.985710142906, 1432.0, 907.382979573883, 911.3119594705954, 945.0785484152896, 953.1612181280428, 1012.1801340913884, 5928.644281343133, 6168.19813424252, 6227.564070515021, 6235.127082208494, 6334.493240540745, 964.80932582706, 1016.5832008876325, 1021.1626466297565, 1042.103790739963, 1043.9739006524746, 3691.8154092295276, 3777.7355585109326, 3806.847726090981, 3825.84696612138, 3830.19565891166, 12124.27254364741, 12311.815322770166, 12425.37873106341, 12461.12772105962, 12525.0, 11728.120390970711, 12118.81821772674, 12131.21147125434, 12138.757224855453, 12247.755044899051, 8819.559022048872, 9188.173064424234, 9212.769680757901, 9226.40028398152, 9228.26173906086, 5997.460228579449, 6169.9691501544, 6215.409536094064, 6324.525660575383, 6654.767083152066, 10814.0, 11100.444977751242, 11184.608538701106, 11296.6046188383, 11406.942965285121, 11407.714807129556, 11660.591879284184, 11798.52805887755, 11854.644360669194, 11955.462004209658, 8521.701740439055, 8755.299576033774, 8826.161514656098, 8829.426087304304, 8924.062973387961, 9801.950990245003, 9834.75413114678, 9846.261530385107, 9870.802583948425, 9931.453770042717, 8467.915320846712, 8692.52191129494, 8851.911480885366, 8879.156480134377, 8979.326550508607, 8227.300679442074, 8367.62345694433, 8581.95709021451, 8643.438176518757, 8806.91193088061, 7420.220876807857, 7448.92551074504, 7486.0, 7503.624818758931, 7531.397488201041, 5064.721440320818, 5145.948540514697, 5194.610404219774, 5205.739713014258, 5295.7087360195555, 5212.087884620252, 5257.316548848626, 5263.842084737464, 5312.070387682217, 5346.064438723286], "value": 5038.227555061307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.1579220364681, 337.4331123712163, 339.98980030599057, 348.2599476113259, 348.98619510322516, 5668.603197776158, 5761.0, 5779.150671785031, 5790.68151251681, 5831.183634291203, 5632.887342253152, 5633.6338138021, 5667.0, 5693.544516438686, 5717.571182161334, 4068.3897415387783, 4168.812403441845, 4382.028087360684, 4397.560243975593, 4404.7357158570585, 4394.1651086293505, 4417.381566580665, 4433.600975912167, 4443.800173953031, 4450.399196108532, 4411.0, 4420.983173870012, 4428.3800267962515, 4435.46774387074, 4453.710508816933, 4247.490301163864, 4395.582429663672, 4411.1618792429335, 4441.888952776174, 4458.331250312447, 3876.4379165021196, 3888.1446081861945, 3901.9609803902167, 3905.902352441183, 3911.5306163260307, 5452.91820622691, 5461.590380721422, 5479.863003424906, 5497.670139791585, 5507.146392309159, 5014.623903207274, 5070.3915530136255, 5077.086124497589, 5121.948780512184, 5128.0, 5905.350411454737, 5915.645061296293, 5922.31893332268, 5943.940560594425, 5972.492338151219, 4300.462442194726, 4316.503602085769, 4319.438472998521, 4344.543822898581, 4349.3475978603465, 6090.512758979271, 6092.817215483498, 6170.691465426711, 6195.783147589857, 6247.562670613059, 4297.140571885635, 4301.440812694393, 4303.612674859215, 4309.439772829513, 4332.545082766327, 4377.737335759864, 4390.638901940409, 4391.736495810262, 4398.428204333416, 4400.757958312323, 4900.485449027872, 5006.822032415911, 5013.245364122601, 5066.544011039025, 5079.238114282887, 5959.433853783884, 5971.0, 5974.163617093611, 5975.52195824333, 5987.251593550806, 1477.566760242563, 1485.413261761598, 1487.5611694550134, 1489.121418363171, 1489.3000289863746, 914.4545717737003, 948.772294649293, 950.0119875329718, 960.5533426956499, 961.4423634292094, 5241.580673546107, 5243.528082472596, 5256.237845512379, 5276.81531146408, 5282.784959459269, 5465.699386533699, 5524.226608274845, 5568.9443105569235, 5576.665400076008, 5578.624931916213, 4893.412790465096, 5166.870828229325, 5207.062728708869, 5279.815206467755, 5292.4707529247535, 2928.2240206345336, 2948.189247956786, 2950.734433900959, 2957.4030023787345, 2962.289050627877, 5735.738137609719, 5736.368999410061, 5740.311162660508, 5751.769929202785, 5764.308283006066, 5184.11869982104, 5569.888602228014, 5587.966226248076, 5620.494155526022, 5652.74562644682, 5649.661020338793, 5659.462351076723, 5662.716864156858, 5745.482906538348, 5781.4218578141845, 5184.403793563638, 5496.697681627389, 5505.944940550704, 5545.694986775605, 5554.416786237387, 5396.568274537949, 5402.432744561922, 5405.540479082087, 5447.509724124848, 5920.407959204045, 6376.947803612352, 6451.612903225829, 6463.289038205699, 6483.384078512534, 6485.189351331083, 4378.75916824565, 4436.3123715824095, 4459.531749166421, 4469.0, 4489.461264648263, 6151.661658608819, 6218.191635087591, 6245.313015568375, 6282.465990390685, 6306.432421082125, 6027.30685971119, 6093.6039157454625, 6101.528880803282, 6102.908456373247, 6129.0, 6036.9698151508965, 6043.7884674036195, 6063.575549711478, 6122.693865306628, 6161.0, 5969.701514924323, 5995.550333724901, 6002.279726432856, 6034.849128771816, 6044.395560443921, 6046.667433291212, 6098.451139397298, 6124.866899623584, 6172.197614310111, 6185.907211391923, 5780.826575202751, 5939.940600594112, 5974.22335096452, 5977.760889564369, 5983.55123365758], "value": 4437.569496466833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.1537569044339, 706.5372181221302, 732.4653003307587, 734.1850545894057, 801.5431204213601, 14263.215523146222, 15396.61508462289, 15409.306581203844, 15439.382424703026, 15449.45926892559, 14932.029418087817, 15093.924530377333, 15111.471098511554, 15121.168335741557, 16677.749833752503, 867.8698195270697, 872.0146234754718, 872.733816186063, 873.0658195730571, 873.5763154869883, 859.7592674051276, 863.8920134983127, 869.8477766390888, 870.1168314161132, 870.1516021878649, 909.5088652127843, 914.0356923445762, 915.327234482658, 915.7069737683944, 917.3945196170529, 904.3714618340223, 904.900460949295, 908.5593487158723, 908.7773495493581, 911.6444586611227, 664.0636702249852, 666.0708311904865, 667.6394746836702, 669.5413641655482, 670.6479098473292, 15511.844881551153, 15607.687846243012, 15613.453529126426, 15623.453179138789, 15650.295736691876, 14773.852261477356, 15266.290944027884, 15327.770083448757, 15466.072035677895, 15585.688286234325, 13559.932200339033, 13645.522406715718, 13692.863071369258, 13712.24582647954, 13816.0, 4591.701539399962, 4668.486466488684, 4674.158651442739, 4683.180443422421, 4698.906021879578, 82731.0, 82851.5857420709, 82911.0, 84201.57899210526, 84722.0, 11959.583893285517, 12362.567310144103, 12394.132410731343, 12420.130590858735, 12469.127161098817, 21104.0, 21119.155233790785, 21135.894320528605, 21151.0, 21153.576928461345, 8259.42184047111, 8369.079401265855, 8381.16188381157, 8518.105598912149, 8588.184122508352, 4625.606823419979, 4687.882802929954, 4779.641526885497, 4818.060478206716, 4827.975860120747, 3476.269983303484, 3566.3402270580027, 3571.339302229096, 3574.3387473317, 3575.481555174485, 629.8205011571772, 641.7785863876956, 642.9174740398432, 647.789468422755, 656.8784774816675, 634.4511997122456, 652.7160685101995, 657.2080642825384, 706.593708617547, 724.9383802376751, 8729.432586881832, 9043.68347107848, 9161.175494205554, 9243.306751993627, 9326.207272381924, 637.4167636612448, 695.290803380549, 706.2266817834463, 716.2729829223342, 723.869703453373, 4448.955510444919, 4537.568930951555, 4553.476350219701, 4563.452385713736, 4642.326862604903, 75842.0, 76067.0, 118177.0, 118580.0, 122895.0, 100168.0, 101117.0, 102570.48714756378, 102750.48624756829, 103071.48464257631, 86934.0, 87083.0, 88808.0, 89361.0, 91409.54295228481, 8746.51894145828, 8772.91227087721, 8857.557122143997, 8919.955400222958, 8940.15068568485, 54824.725876370365, 55528.0, 55742.0, 56071.43928560662, 56769.71615142063, 72809.0, 76332.0, 76831.61584192043, 76970.23029769855, 76972.61513692395, 9979.750506237402, 10172.745681358025, 10668.30656007357, 10683.89316106829, 10759.3544387337, 12580.622581322576, 12637.2417654941, 12672.493100275886, 12715.80926286088, 13298.069135160446, 11269.830952535882, 11459.942700286778, 11505.137114716263, 11706.063514918616, 11730.296182228753, 11445.599404020819, 11561.710957226136, 11877.287362758263, 11928.1053920958, 12156.331401772988, 10848.945755271174, 11039.0, 11302.717432064264, 11504.482298296429, 11745.882541174478, 9210.710500530065, 9345.0, 9400.717978460658, 9410.670626528039, 9566.473843938651, 9512.95243523778, 9623.518824058629, 9631.325807193709, 9688.176504997155, 9693.273004524548], "value": 7469.631933170226, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 109.0, 113.0, 111.0, 110.0, 111.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 150.0, 177.0, 124.0, 157.0, 162.0, 126.0, 181.0, 125.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 175.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 76.0, 162.0, 83.0, 75.0, 75.0, 75.0, 177.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 142.0, 88.0, 87.0, 85.0, 128.0, 83.0, 85.0, 137.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 145.0, 148.0, 146.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 100.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 53.0, 53.0, 58.0, 53.0, 53.0, 57.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 76.0, 77.0, 83.0, 82.0, 78.0, 102.0, 77.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 120.0, 135.0, 128.0, 121.0, 125.0, 127.0, 132.0, 124.0, 133.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 153.0, 154.0, 150.0, 154.0, 153.0, 153.0, 151.0, 155.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 63.0, 64.0, 66.0, 64.0, 62.0, 63.0, 63.0, 62.0], "value": 63.8, "unit": "score"}]}]} 04:33:38 INFO - Return code: 0 04:33:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:38 ERROR - # TBPL SUCCESS # 04:33:38 INFO - Running post-action listener: _resource_record_post_action 04:33:38 INFO - ##### 04:33:38 INFO - ##### Finished run-tests step (success) 04:33:38 INFO - ##### 04:33:38 INFO - Running post-run listener: _resource_record_post_run 04:33:38 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 286453760; Read time: 0; Write time: 147928 04:33:38 INFO - TinderboxPrint: CPU usage
13.3% 04:33:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:33:38 INFO - TinderboxPrint: I/O write bytes / time
286,453,760 / 147,928 04:33:38 INFO - TinderboxPrint: CPU idle
8,193.1 (86.6%) 04:33:38 INFO - TinderboxPrint: CPU user
1,211.4 (12.8%) 04:33:38 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:38 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 68636672; Read time: 0; Write time: 56396 04:33:38 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 215334912; Read time: 0; Write time: 91352 04:33:39 INFO - Running post-run listener: _upload_blobber_files 04:33:39 INFO - Blob upload gear active. 04:33:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:33:39 INFO - Traceback (most recent call last): 04:33:39 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 04:33:39 INFO - main() 04:33:39 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 04:33:39 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 04:33:39 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 04:33:39 INFO - return set(response.json().get('whitelist', [])) 04:33:39 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 04:33:39 INFO - return json.loads(self.text or self.content, **kwargs) 04:33:39 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 04:33:39 INFO - return _default_decoder.decode(s) 04:33:39 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 04:33:39 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 04:33:39 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 04:33:39 INFO - raise ValueError("No JSON object could be decoded") 04:33:39 INFO - ValueError: No JSON object could be decoded 04:33:39 ERROR - Return code: 1 04:33:39 INFO - Setting buildbot property blobber_files to {} 04:33:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:39 INFO - Contents: 04:33:39 INFO - blobber_files:{} 04:33:39 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:39 INFO - Copying logs to upload dir... 04:33:39 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1669.589736 ========= 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:38.730662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:38.735484) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134 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.011244 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.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:38.761504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:38.761842) ========= 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=bb9b54edd4a927dc735d112f000001d9-1472382347.378553-763237134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:38.814107) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:38.814583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:38.814998) ========= ========= Total master_lag: 0.14 =========