builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1470332998.79 results: success (0) buildid: 20160804080522 builduid: 0b796fb3a6b84105809eb81b95c591f2 revision: 942d7567e119d48bd129f2850fabe2dd687a0476 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:58.787483) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:58.788032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:58.788300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:58.803441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:58.803706) ========= 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=0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:49:58-- 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% 37.8M=0s 2016-08-04 10:49:59 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136911 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:59.146843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:59.147353) ========= 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=0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018733 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:49:59.197016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 10:49:59.197324) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 942d7567e119d48bd129f2850fabe2dd687a0476 --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 942d7567e119d48bd129f2850fabe2dd687a0476 --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=0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:49:59,336 truncating revision to first 12 chars 2016-08-04 10:49:59,337 Setting DEBUG logging. 2016-08-04 10:49:59,337 attempt 1/10 2016-08-04 10:49:59,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/942d7567e119?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:50:00,767 unpacking tar archive at: mozilla-beta-942d7567e119/testing/mozharness/ program finished with exit code 0 elapsedTime=1.770891 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 10:50:00.984623) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.984980) ========= script_repo_revision: 942d7567e119d48bd129f2850fabe2dd687a0476 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.985387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.985657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:00.995879) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-04 10:50:00.996231) ========= /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=0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:01 INFO - MultiFileLogger online at 20160804 10:50:01 in /builds/slave/test 10:50:01 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 10:50:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:01 INFO - {'append_to_log': False, 10:50:01 INFO - 'base_work_dir': '/builds/slave/test', 10:50:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:50:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:01 INFO - 'branch': 'Mozilla-Beta', 10:50:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:01 INFO - 'config_files': ('talos/linux_config.py',), 10:50:01 INFO - 'default_actions': ('clobber', 10:50:01 INFO - 'read-buildbot-config', 10:50:01 INFO - 'download-and-extract', 10:50:01 INFO - 'populate-webroot', 10:50:01 INFO - 'create-virtualenv', 10:50:01 INFO - 'install', 10:50:01 INFO - 'run-tests'), 10:50:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:01 INFO - 'download_minidump_stackwalk': True, 10:50:01 INFO - 'download_symbols': 'ondemand', 10:50:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:01 INFO - 'installer_path': 'installer.exe', 10:50:01 INFO - 'log_level': 'info', 10:50:01 INFO - 'log_name': 'talos', 10:50:01 INFO - 'log_to_console': True, 10:50:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:01 INFO - 'opt_config_files': (), 10:50:01 INFO - 'pip_index': False, 10:50:01 INFO - 'sps_profile': False, 10:50:01 INFO - 'sps_profile_interval': 0, 10:50:01 INFO - 'suite': 'dromaeojs-e10s', 10:50:01 INFO - 'system_bits': '32', 10:50:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:01 INFO - 'title': 'talos-linux64-ix-017', 10:50:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:01 INFO - 'use_talos_json': True, 10:50:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:01 INFO - 'work_dir': 'build'} 10:50:01 INFO - ##### 10:50:01 INFO - ##### Running clobber step. 10:50:01 INFO - ##### 10:50:01 INFO - Running pre-action listener: _resource_record_pre_action 10:50:01 INFO - Running main action method: clobber 10:50:01 INFO - rmtree: /builds/slave/test/build 10:50:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:01 INFO - Running post-action listener: _resource_record_post_action 10:50:01 INFO - ##### 10:50:01 INFO - ##### Finished clobber step (success) 10:50:01 INFO - ##### 10:50:01 INFO - ##### 10:50:01 INFO - ##### Running read-buildbot-config step. 10:50:01 INFO - ##### 10:50:01 INFO - Running pre-action listener: _resource_record_pre_action 10:50:01 INFO - Running main action method: read_buildbot_config 10:50:01 INFO - Using buildbot properties: 10:50:01 INFO - { 10:50:01 INFO - "project": "", 10:50:01 INFO - "product": "firefox", 10:50:01 INFO - "script_repo_revision": "production", 10:50:01 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:50:01 INFO - "repository": "", 10:50:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:50:01 INFO - "buildid": "20160804080522", 10:50:01 INFO - "pgo_build": "True", 10:50:01 INFO - "basedir": "/builds/slave/test", 10:50:01 INFO - "buildnumber": 197, 10:50:01 INFO - "slavename": "talos-linux64-ix-017", 10:50:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:50:01 INFO - "platform": "ubuntu64_hw", 10:50:01 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:50:01 INFO - "branch": "mozilla-beta", 10:50:01 INFO - "repo_path": "releases/mozilla-beta", 10:50:01 INFO - "revision": "942d7567e119d48bd129f2850fabe2dd687a0476", 10:50:01 INFO - "stage_platform": "linux64-pgo", 10:50:01 INFO - "builduid": "0b796fb3a6b84105809eb81b95c591f2", 10:50:01 INFO - "slavebuilddir": "test" 10:50:01 INFO - } 10:50:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 10:50:01 INFO - Running post-action listener: _resource_record_post_action 10:50:01 INFO - ##### 10:50:01 INFO - ##### Finished read-buildbot-config step (success) 10:50:01 INFO - ##### 10:50:01 INFO - ##### 10:50:01 INFO - ##### Running download-and-extract step. 10:50:01 INFO - ##### 10:50:01 INFO - Running pre-action listener: _resource_record_pre_action 10:50:01 INFO - Running main action method: download_and_extract 10:50:01 INFO - mkdir: /builds/slave/test/build/tests 10:50:01 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')]} 10:50:01 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:02 INFO - Downloaded 1327 bytes. 10:50:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:02 INFO - Using the following test package requirements: 10:50:02 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 10:50:02 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:02 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 10:50:02 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'jsshell-linux-x86_64.zip'], 10:50:02 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:02 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 10:50:02 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 10:50:02 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 10:50:02 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:02 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:02 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:02 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:02 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:03 INFO - Downloaded 21968842 bytes. 10:50:03 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'] 10:50:03 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 10:50:04 INFO - Return code: 0 10:50:04 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 10:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:04 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:06 INFO - Downloaded 21968842 bytes. 10:50:06 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'] 10:50:06 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 10:50:08 INFO - Return code: 0 10:50:08 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')]} 10:50:08 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:09 INFO - Downloaded 10833369 bytes. 10:50:09 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'] 10:50:09 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 10:50:09 INFO - Return code: 0 10:50:09 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')]} 10:50:09 INFO - https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:50:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wu_kQKnNQIW4_pjer6nZzA/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 10:50:12 INFO - Downloaded 55286878 bytes. 10:50:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:12 INFO - mkdir: /builds/slave/test/properties 10:50:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:12 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:12 INFO - Contents: 10:50:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:50:13 INFO - Running post-action listener: _resource_record_post_action 10:50:13 INFO - Running post-action listener: set_extra_try_arguments 10:50:13 INFO - ##### 10:50:13 INFO - ##### Finished download-and-extract step (success) 10:50:13 INFO - ##### 10:50:13 INFO - ##### 10:50:13 INFO - ##### Running populate-webroot step. 10:50:13 INFO - ##### 10:50:13 INFO - Running pre-action listener: _resource_record_pre_action 10:50:13 INFO - Running main action method: populate_webroot 10:50:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:50:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:50:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:50:13 INFO - '--tppagecycles', 10:50:13 INFO - '7'], 10:50:13 INFO - 'tests': ['tsvgm']}}, 10:50:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:50:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:50:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['damp', 'tps']}, 10:50:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'tests': ['damp', 'tps']}, 10:50:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['dromaeo_dom']}, 10:50:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['a11yr', 10:50:13 INFO - 'ts_paint', 10:50:13 INFO - 'tpaint', 10:50:13 INFO - 'sessionrestore', 10:50:13 INFO - 'sessionrestore_no_auto_restore', 10:50:13 INFO - 'tabpaint']}, 10:50:13 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:13 INFO - 'ts_paint', 10:50:13 INFO - 'tpaint', 10:50:13 INFO - 'sessionrestore', 10:50:13 INFO - 'sessionrestore_no_auto_restore', 10:50:13 INFO - 'tabpaint']}, 10:50:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:50:13 INFO - 'ts_paint', 10:50:13 INFO - 'tpaint', 10:50:13 INFO - 'sessionrestore', 10:50:13 INFO - 'sessionrestore_no_auto_restore', 10:50:13 INFO - 'tabpaint']}, 10:50:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:50:13 INFO - 'ts_paint', 10:50:13 INFO - 'tpaint', 10:50:13 INFO - 'sessionrestore', 10:50:13 INFO - 'sessionrestore_no_auto_restore', 10:50:13 INFO - 'tabpaint']}, 10:50:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['a11yr', 10:50:13 INFO - 'ts_paint', 10:50:13 INFO - 'tpaint', 10:50:13 INFO - 'sessionrestore', 10:50:13 INFO - 'sessionrestore_no_auto_restore', 10:50:13 INFO - 'tabpaint']}, 10:50:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['a11yr', 10:50:13 INFO - 'ts_paint', 10:50:13 INFO - 'tpaint', 10:50:13 INFO - 'sessionrestore', 10:50:13 INFO - 'sessionrestore_no_auto_restore', 10:50:13 INFO - 'tabpaint']}, 10:50:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['tsvgx', 10:50:13 INFO - 'tsvgr_opacity', 10:50:13 INFO - 'tart', 10:50:13 INFO - 'tscrollx', 10:50:13 INFO - 'cart']}, 10:50:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:13 INFO - 'tsvgr_opacity', 10:50:13 INFO - 'tart', 10:50:13 INFO - 'tscrollx', 10:50:13 INFO - 'cart']}, 10:50:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'talos_options': ['--disable-e10s'], 10:50:13 INFO - 'tests': ['tp5o']}, 10:50:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'tests': ['tp5o']}, 10:50:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'talos_options': ['--disable-e10s', 10:50:13 INFO - '--xperf_path', 10:50:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:13 INFO - 'tests': ['tp5n']}, 10:50:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:50:13 INFO - 'talos_options': ['--xperf_path', 10:50:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:13 INFO - 'tests': ['tp5n']}}, 10:50:13 INFO - 'talos.zip': {'path': '', 10:50:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:50:13 INFO - Running post-action listener: _resource_record_post_action 10:50:13 INFO - ##### 10:50:13 INFO - ##### Finished populate-webroot step (success) 10:50:13 INFO - ##### 10:50:13 INFO - ##### 10:50:13 INFO - ##### Running create-virtualenv step. 10:50:13 INFO - ##### 10:50:13 INFO - Running pre-action listener: _resource_record_pre_action 10:50:13 INFO - Running main action method: create_virtualenv 10:50:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:13 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 10:50:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:13 INFO - Using real prefix '/usr' 10:50:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:15 INFO - Installing pip.................done. 10:50:15 INFO - Return code: 0 10:50:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:50:15 INFO - Using env: {'DISPLAY': ':0', 10:50:15 INFO - 'HOME': '/home/cltbld', 10:50:15 INFO - 'LANG': 'en_US.UTF-8', 10:50:15 INFO - 'LANGUAGE': 'en_US:en', 10:50:15 INFO - 'LOGNAME': 'cltbld', 10:50:15 INFO - 'MAIL': '/var/mail/cltbld', 10:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:15 INFO - 'MOZ_NO_REMOTE': '1', 10:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:15 INFO - 'NO_EM_RESTART': '1', 10:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:15 INFO - 'PWD': '/builds/slave/test', 10:50:16 INFO - 'SHELL': '/bin/bash', 10:50:16 INFO - 'SHLVL': '1', 10:50:16 INFO - 'TERM': 'linux', 10:50:16 INFO - 'TMOUT': '86400', 10:50:16 INFO - 'USER': 'cltbld', 10:50:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:16 INFO - '_': '/tools/buildbot/bin/python'} 10:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:16 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 10:50:16 INFO - Cleaning up... 10:50:16 INFO - Return code: 0 10:50:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:16 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:16 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 10:50:16 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 10:50:16 INFO - Using env: {'DISPLAY': ':0', 10:50:16 INFO - 'HOME': '/home/cltbld', 10:50:16 INFO - 'LANG': 'en_US.UTF-8', 10:50:16 INFO - 'LANGUAGE': 'en_US:en', 10:50:16 INFO - 'LOGNAME': 'cltbld', 10:50:16 INFO - 'MAIL': '/var/mail/cltbld', 10:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:16 INFO - 'MOZ_NO_REMOTE': '1', 10:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:16 INFO - 'NO_EM_RESTART': '1', 10:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:16 INFO - 'PWD': '/builds/slave/test', 10:50:16 INFO - 'SHELL': '/bin/bash', 10:50:16 INFO - 'SHLVL': '1', 10:50:16 INFO - 'TERM': 'linux', 10:50:16 INFO - 'TMOUT': '86400', 10:50:16 INFO - 'USER': 'cltbld', 10:50:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:16 INFO - '_': '/tools/buildbot/bin/python'} 10:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:16 INFO - Downloading/unpacking psutil>=3.1.1 10:50:16 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 10:50:16 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 10:50:16 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 10:50:16 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 10:50:16 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 10:50:16 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 10:50:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:18 INFO - Installing collected packages: psutil 10:50:18 INFO - Running setup.py install for psutil 10:50:18 INFO - building 'psutil._psutil_linux' extension 10:50:18 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 10:50:18 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 10:50:18 INFO - building 'psutil._psutil_posix' extension 10:50:18 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 10:50:18 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 10:50:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:18 INFO - Successfully installed psutil 10:50:18 INFO - Cleaning up... 10:50:18 INFO - Return code: 0 10:50:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:50:18 INFO - Using env: {'DISPLAY': ':0', 10:50:18 INFO - 'HOME': '/home/cltbld', 10:50:18 INFO - 'LANG': 'en_US.UTF-8', 10:50:18 INFO - 'LANGUAGE': 'en_US:en', 10:50:18 INFO - 'LOGNAME': 'cltbld', 10:50:18 INFO - 'MAIL': '/var/mail/cltbld', 10:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:18 INFO - 'MOZ_NO_REMOTE': '1', 10:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:18 INFO - 'NO_EM_RESTART': '1', 10:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:18 INFO - 'PWD': '/builds/slave/test', 10:50:18 INFO - 'SHELL': '/bin/bash', 10:50:18 INFO - 'SHLVL': '1', 10:50:18 INFO - 'TERM': 'linux', 10:50:18 INFO - 'TMOUT': '86400', 10:50:18 INFO - 'USER': 'cltbld', 10:50:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:18 INFO - '_': '/tools/buildbot/bin/python'} 10:50:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50:19 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 10:50:19 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 10:50:19 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 10:50:19 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 10:50:19 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 10:50:19 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 10:50:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:21 INFO - Installing collected packages: mozsystemmonitor 10:50:21 INFO - Running setup.py install for mozsystemmonitor 10:50:21 INFO - Successfully installed mozsystemmonitor 10:50:21 INFO - Cleaning up... 10:50:21 INFO - Return code: 0 10:50:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:21 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:21 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 10:50:21 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 10:50:21 INFO - Using env: {'DISPLAY': ':0', 10:50:21 INFO - 'HOME': '/home/cltbld', 10:50:21 INFO - 'LANG': 'en_US.UTF-8', 10:50:21 INFO - 'LANGUAGE': 'en_US:en', 10:50:21 INFO - 'LOGNAME': 'cltbld', 10:50:21 INFO - 'MAIL': '/var/mail/cltbld', 10:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:21 INFO - 'MOZ_NO_REMOTE': '1', 10:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:21 INFO - 'NO_EM_RESTART': '1', 10:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:21 INFO - 'PWD': '/builds/slave/test', 10:50:21 INFO - 'SHELL': '/bin/bash', 10:50:21 INFO - 'SHLVL': '1', 10:50:21 INFO - 'TERM': 'linux', 10:50:21 INFO - 'TMOUT': '86400', 10:50:21 INFO - 'USER': 'cltbld', 10:50:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:21 INFO - '_': '/tools/buildbot/bin/python'} 10:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:21 INFO - Downloading/unpacking jsonschema==2.5.1 10:50:21 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 10:50:21 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 10:50:21 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 10:50:21 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 10:50:21 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 10:50:21 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 10:50:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:23 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 10:50:23 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 10:50:23 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 10:50:23 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 10:50:23 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 10:50:23 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 10:50:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:23 INFO - warning: no files found matching '*.txt' 10:50:23 INFO - no previously-included directories found matching 'build' 10:50:23 INFO - no previously-included directories found matching 'dist' 10:50:23 INFO - no previously-included directories found matching '.git*' 10:50:23 INFO - Installing collected packages: jsonschema, functools32 10:50:23 INFO - Running setup.py install for functools32 10:50:23 INFO - warning: no files found matching '*.txt' 10:50:23 INFO - no previously-included directories found matching 'build' 10:50:23 INFO - no previously-included directories found matching 'dist' 10:50:23 INFO - no previously-included directories found matching '.git*' 10:50:23 INFO - Successfully installed jsonschema functools32 10:50:23 INFO - Cleaning up... 10:50:23 INFO - Return code: 0 10:50:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:23 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:23 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 10:50:23 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 10:50:23 INFO - Using env: {'DISPLAY': ':0', 10:50:23 INFO - 'HOME': '/home/cltbld', 10:50:23 INFO - 'LANG': 'en_US.UTF-8', 10:50:23 INFO - 'LANGUAGE': 'en_US:en', 10:50:23 INFO - 'LOGNAME': 'cltbld', 10:50:23 INFO - 'MAIL': '/var/mail/cltbld', 10:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:23 INFO - 'MOZ_NO_REMOTE': '1', 10:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:23 INFO - 'NO_EM_RESTART': '1', 10:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:23 INFO - 'PWD': '/builds/slave/test', 10:50:23 INFO - 'SHELL': '/bin/bash', 10:50:23 INFO - 'SHLVL': '1', 10:50:23 INFO - 'TERM': 'linux', 10:50:23 INFO - 'TMOUT': '86400', 10:50:23 INFO - 'USER': 'cltbld', 10:50:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:23 INFO - '_': '/tools/buildbot/bin/python'} 10:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:24 INFO - Downloading/unpacking blobuploader==1.2.4 10:50:24 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 10:50:24 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 10:50:24 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 10:50:24 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 10:50:24 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 10:50:24 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 10:50:25 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50:25 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 10:50:25 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 10:50:25 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 10:50:25 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 10:50:25 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 10:50:25 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 10:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:26 INFO - Downloading docopt-0.6.1.tar.gz 10:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:50:26 INFO - Installing collected packages: blobuploader, requests, docopt 10:50:26 INFO - Running setup.py install for blobuploader 10:50:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:50:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:50:26 INFO - Running setup.py install for requests 10:50:27 INFO - Running setup.py install for docopt 10:50:27 INFO - Successfully installed blobuploader requests docopt 10:50:27 INFO - Cleaning up... 10:50:27 INFO - Return code: 0 10:50:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:27 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:27 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 10:50:27 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 10:50:27 INFO - Using env: {'DISPLAY': ':0', 10:50:27 INFO - 'HOME': '/home/cltbld', 10:50:27 INFO - 'LANG': 'en_US.UTF-8', 10:50:27 INFO - 'LANGUAGE': 'en_US:en', 10:50:27 INFO - 'LOGNAME': 'cltbld', 10:50:27 INFO - 'MAIL': '/var/mail/cltbld', 10:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:27 INFO - 'MOZ_NO_REMOTE': '1', 10:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:27 INFO - 'NO_EM_RESTART': '1', 10:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:27 INFO - 'PWD': '/builds/slave/test', 10:50:27 INFO - 'SHELL': '/bin/bash', 10:50:27 INFO - 'SHLVL': '1', 10:50:27 INFO - 'TERM': 'linux', 10:50:27 INFO - 'TMOUT': '86400', 10:50:27 INFO - 'USER': 'cltbld', 10:50:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:27 INFO - '_': '/tools/buildbot/bin/python'} 10:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:27 INFO - Running setup.py (path:/tmp/pip-sYUcqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:27 INFO - Running setup.py (path:/tmp/pip-hUDru_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:28 INFO - Running setup.py (path:/tmp/pip-RSeBgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:28 INFO - Running setup.py (path:/tmp/pip-rDNvt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:28 INFO - Running setup.py (path:/tmp/pip-FdBo7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:28 INFO - Running setup.py (path:/tmp/pip-8tzDTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:28 INFO - Running setup.py (path:/tmp/pip-V4ZACL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:28 INFO - Running setup.py (path:/tmp/pip-C1hABL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:28 INFO - Running setup.py (path:/tmp/pip-qyN7Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:28 INFO - Running setup.py (path:/tmp/pip-i8IwOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:28 INFO - Running setup.py (path:/tmp/pip-_ORm0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:28 INFO - Running setup.py (path:/tmp/pip-IiwUso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:28 INFO - Running setup.py (path:/tmp/pip-QOZ8PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:28 INFO - Running setup.py (path:/tmp/pip-p2nRRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:28 INFO - Running setup.py (path:/tmp/pip-ZKQnlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:28 INFO - Running setup.py (path:/tmp/pip-yd0BnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:29 INFO - Running setup.py (path:/tmp/pip-WKw3UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:50:29 INFO - Running setup.py install for manifestparser 10:50:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Running setup.py install for mozcrash 10:50:29 INFO - Running setup.py install for mozdebug 10:50:29 INFO - Running setup.py install for mozdevice 10:50:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Running setup.py install for mozfile 10:50:29 INFO - Running setup.py install for mozhttpd 10:50:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Running setup.py install for mozinfo 10:50:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Running setup.py install for mozInstall 10:50:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:50:29 INFO - Running setup.py install for mozleak 10:50:30 INFO - Running setup.py install for mozlog 10:50:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:50:30 INFO - Running setup.py install for moznetwork 10:50:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:50:30 INFO - Running setup.py install for mozprocess 10:50:30 INFO - Running setup.py install for mozprofile 10:50:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:50:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:50:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:50:30 INFO - Running setup.py install for mozrunner 10:50:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:50:30 INFO - Running setup.py install for mozscreenshot 10:50:30 INFO - Running setup.py install for moztest 10:50:30 INFO - Running setup.py install for mozversion 10:50:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:50:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:50:30 INFO - Cleaning up... 10:50:30 INFO - Return code: 0 10:50:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:30 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')]} 10:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:30 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')]} 10:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:30 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:30 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 10:50:30 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 10:50:30 INFO - Using env: {'DISPLAY': ':0', 10:50:30 INFO - 'HOME': '/home/cltbld', 10:50:30 INFO - 'LANG': 'en_US.UTF-8', 10:50:30 INFO - 'LANGUAGE': 'en_US:en', 10:50:30 INFO - 'LOGNAME': 'cltbld', 10:50:30 INFO - 'MAIL': '/var/mail/cltbld', 10:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:30 INFO - 'MOZ_NO_REMOTE': '1', 10:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:30 INFO - 'NO_EM_RESTART': '1', 10:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:30 INFO - 'PWD': '/builds/slave/test', 10:50:30 INFO - 'SHELL': '/bin/bash', 10:50:30 INFO - 'SHLVL': '1', 10:50:30 INFO - 'TERM': 'linux', 10:50:30 INFO - 'TMOUT': '86400', 10:50:30 INFO - 'USER': 'cltbld', 10:50:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:30 INFO - '_': '/tools/buildbot/bin/python'} 10:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:31 INFO - Running setup.py (path:/tmp/pip-ugOAJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:31 INFO - Running setup.py (path:/tmp/pip-wIEO53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:31 INFO - Running setup.py (path:/tmp/pip-AkCOJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:31 INFO - Running setup.py (path:/tmp/pip-W1n06f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:31 INFO - Running setup.py (path:/tmp/pip-EjYbA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:31 INFO - Running setup.py (path:/tmp/pip-GLRaIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:31 INFO - Running setup.py (path:/tmp/pip-4R8ZcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:31 INFO - Running setup.py (path:/tmp/pip-jsCuTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:31 INFO - Running setup.py (path:/tmp/pip-JuMO0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:31 INFO - Running setup.py (path:/tmp/pip-ktbGlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:31 INFO - Running setup.py (path:/tmp/pip-jeIgSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:31 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)) 10:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:31 INFO - Running setup.py (path:/tmp/pip-PP1uff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:32 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)) 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:32 INFO - Running setup.py (path:/tmp/pip-deWh2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:32 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)) 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:32 INFO - Running setup.py (path:/tmp/pip-oRCagq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:32 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)) 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:32 INFO - Running setup.py (path:/tmp/pip-5bwuck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:32 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)) 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:32 INFO - Running setup.py (path:/tmp/pip-54PF8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:32 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)) 10:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:32 INFO - Running setup.py (path:/tmp/pip-qGgG2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:32 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)) 10:50:32 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)) 10:50:32 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)) 10:50:32 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)) 10:50:32 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)) 10:50:32 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)) 10:50:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:34 INFO - Downloading blessings-1.6.tar.gz 10:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:50:34 INFO - Installing collected packages: blessings 10:50:34 INFO - Running setup.py install for blessings 10:50:34 INFO - Successfully installed blessings 10:50:34 INFO - Cleaning up... 10:50:34 INFO - Return code: 0 10:50:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:50:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:34 INFO - Reading from file tmpfile_stdout 10:50:34 INFO - Current package versions: 10:50:34 INFO - argparse == 1.2.1 10:50:34 INFO - blessings == 1.6 10:50:34 INFO - blobuploader == 1.2.4 10:50:34 INFO - docopt == 0.6.1 10:50:34 INFO - functools32 == 3.2.3-2 10:50:34 INFO - jsonschema == 2.5.1 10:50:34 INFO - manifestparser == 1.1 10:50:34 INFO - mozInstall == 1.12 10:50:34 INFO - mozcrash == 0.17 10:50:34 INFO - mozdebug == 0.1 10:50:34 INFO - mozdevice == 0.48 10:50:34 INFO - mozfile == 1.2 10:50:34 INFO - mozhttpd == 0.7 10:50:34 INFO - mozinfo == 0.9 10:50:34 INFO - mozleak == 0.1 10:50:34 INFO - mozlog == 3.2 10:50:34 INFO - moznetwork == 0.27 10:50:34 INFO - mozprocess == 0.23 10:50:34 INFO - mozprofile == 0.28 10:50:34 INFO - mozrunner == 6.12 10:50:34 INFO - mozscreenshot == 0.1 10:50:34 INFO - mozsystemmonitor == 0.3 10:50:34 INFO - moztest == 0.7 10:50:34 INFO - mozversion == 1.4 10:50:34 INFO - psutil == 3.1.1 10:50:34 INFO - requests == 1.2.3 10:50:34 INFO - wsgiref == 0.1.2 10:50:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50: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')]} 10:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:34 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:34 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 10:50:34 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 10:50:34 INFO - Using env: {'DISPLAY': ':0', 10:50:34 INFO - 'HOME': '/home/cltbld', 10:50:34 INFO - 'LANG': 'en_US.UTF-8', 10:50:34 INFO - 'LANGUAGE': 'en_US:en', 10:50:34 INFO - 'LOGNAME': 'cltbld', 10:50:34 INFO - 'MAIL': '/var/mail/cltbld', 10:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:34 INFO - 'MOZ_NO_REMOTE': '1', 10:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:34 INFO - 'NO_EM_RESTART': '1', 10:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:34 INFO - 'PWD': '/builds/slave/test', 10:50:34 INFO - 'SHELL': '/bin/bash', 10:50:34 INFO - 'SHLVL': '1', 10:50:34 INFO - 'TERM': 'linux', 10:50:34 INFO - 'TMOUT': '86400', 10:50:34 INFO - 'USER': 'cltbld', 10:50:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:34 INFO - '_': '/tools/buildbot/bin/python'} 10:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 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)) 10:50:35 INFO - Cleaning up... 10:50:35 INFO - Return code: 0 10:50:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:35 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 10:50:35 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 10:50:35 INFO - Using env: {'DISPLAY': ':0', 10:50:35 INFO - 'HOME': '/home/cltbld', 10:50:35 INFO - 'LANG': 'en_US.UTF-8', 10:50:35 INFO - 'LANGUAGE': 'en_US:en', 10:50:35 INFO - 'LOGNAME': 'cltbld', 10:50:35 INFO - 'MAIL': '/var/mail/cltbld', 10:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:35 INFO - 'MOZ_NO_REMOTE': '1', 10:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:35 INFO - 'NO_EM_RESTART': '1', 10:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:35 INFO - 'PWD': '/builds/slave/test', 10:50:35 INFO - 'SHELL': '/bin/bash', 10:50:35 INFO - 'SHLVL': '1', 10:50:35 INFO - 'TERM': 'linux', 10:50:35 INFO - 'TMOUT': '86400', 10:50:35 INFO - 'USER': 'cltbld', 10:50:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:35 INFO - '_': '/tools/buildbot/bin/python'} 10:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:50:35 INFO - Cleaning up... 10:50:35 INFO - Return code: 0 10:50:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:50:35 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 0x7fa8a6a30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, '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': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', '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 10:50:35 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 10:50:35 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 10:50:35 INFO - Using env: {'DISPLAY': ':0', 10:50:35 INFO - 'HOME': '/home/cltbld', 10:50:35 INFO - 'LANG': 'en_US.UTF-8', 10:50:35 INFO - 'LANGUAGE': 'en_US:en', 10:50:35 INFO - 'LOGNAME': 'cltbld', 10:50:35 INFO - 'MAIL': '/var/mail/cltbld', 10:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:35 INFO - 'MOZ_NO_REMOTE': '1', 10:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:35 INFO - 'NO_EM_RESTART': '1', 10:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:35 INFO - 'PWD': '/builds/slave/test', 10:50:35 INFO - 'SHELL': '/bin/bash', 10:50:35 INFO - 'SHLVL': '1', 10:50:35 INFO - 'TERM': 'linux', 10:50:35 INFO - 'TMOUT': '86400', 10:50:35 INFO - 'USER': 'cltbld', 10:50:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:35 INFO - '_': '/tools/buildbot/bin/python'} 10:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:35 INFO - Downloading/unpacking flake8 10:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:50:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:50:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:50:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:50:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:50:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:50:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:50:38 INFO - no previously-included directories found matching 'docs/_build' 10:50:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:50:38 INFO - Running setup.py install for pep8 10:50:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:50:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:50:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:50:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:50:38 INFO - no previously-included directories found matching 'docs/_build' 10:50:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:50:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:50:38 INFO - Cleaning up... 10:50:38 INFO - Return code: 0 10:50:38 INFO - Running post-action listener: _resource_record_post_action 10:50:38 INFO - Running post-action listener: _start_resource_monitoring 10:50:38 INFO - Starting resource monitoring. 10:50:38 INFO - ##### 10:50:38 INFO - ##### Finished create-virtualenv step (success) 10:50:38 INFO - ##### 10:50:38 INFO - ##### 10:50:38 INFO - ##### Running install step. 10:50:38 INFO - ##### 10:50:38 INFO - Running pre-action listener: _resource_record_pre_action 10:50:38 INFO - Running main action method: install 10:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:38 INFO - Reading from file tmpfile_stdout 10:50:38 INFO - Detecting whether we're running mozinstall >=1.0... 10:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:50:38 INFO - Reading from file tmpfile_stdout 10:50:38 INFO - Output received: 10:50:38 INFO - Usage: mozinstall [options] installer 10:50:38 INFO - Options: 10:50:38 INFO - -h, --help show this help message and exit 10:50:38 INFO - -d DEST, --destination=DEST 10:50:38 INFO - Directory to install application into. [default: 10:50:38 INFO - "/builds/slave/test"] 10:50:38 INFO - --app=APP Application being installed. [default: firefox] 10:50:38 INFO - mkdir: /builds/slave/test/build/application 10:50:38 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'] 10:50:38 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 10:50:51 INFO - Reading from file tmpfile_stdout 10:50:51 INFO - Output received: 10:50:51 INFO - /builds/slave/test/build/application/firefox/firefox 10:50:51 INFO - Running post-action listener: _resource_record_post_action 10:50:51 INFO - ##### 10:50:51 INFO - ##### Finished install step (success) 10:50:51 INFO - ##### 10:50:51 INFO - ##### 10:50:51 INFO - ##### Running run-tests step. 10:50:51 INFO - ##### 10:50:51 INFO - Running pre-action listener: _resource_record_pre_action 10:50:51 INFO - Running main action method: run_tests 10:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:51 INFO - Python 2.7.3 10:50:51 INFO - Return code: 0 10:50:51 INFO - grabbing minidump binary from tooltool 10:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:51 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 0x156c1c0>, '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 0x156d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:51 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 10:50:51 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 10:50:51 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 10:50:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:51 INFO - Return code: 0 10:50:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:50:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:50:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:50:52 INFO - Return code: 0 10:50:52 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/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:50:52 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/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 10:50:52 INFO - Using env: {'DISPLAY': ':0', 10:50:52 INFO - 'HOME': '/home/cltbld', 10:50:52 INFO - 'LANG': 'en_US.UTF-8', 10:50:52 INFO - 'LANGUAGE': 'en_US:en', 10:50:52 INFO - 'LOGNAME': 'cltbld', 10:50:52 INFO - 'MAIL': '/var/mail/cltbld', 10:50:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:52 INFO - 'MOZ_NO_REMOTE': '1', 10:50:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:52 INFO - 'NO_EM_RESTART': '1', 10:50:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:52 INFO - 'PWD': '/builds/slave/test', 10:50:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:52 INFO - 'SHELL': '/bin/bash', 10:50:52 INFO - 'SHLVL': '1', 10:50:52 INFO - 'TERM': 'linux', 10:50:52 INFO - 'TMOUT': '86400', 10:50:52 INFO - 'USER': 'cltbld', 10:50:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989', 10:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:52 INFO - '_': '/tools/buildbot/bin/python'} 10:50:52 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/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 10:50:53 INFO - mozversion application_buildid: 20160804080522 10:50:53 INFO - mozversion application_changeset: 942d7567e119d48bd129f2850fabe2dd687a0476 10:50:53 INFO - mozversion application_display_name: Firefox 10:50:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:53 INFO - mozversion application_name: Firefox 10:50:53 INFO - mozversion application_remotingname: firefox 10:50:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:50:53 INFO - mozversion application_vendor: Mozilla 10:50:53 INFO - mozversion application_version: 49.0 10:50:53 INFO - mozversion platform_buildid: 20160804080522 10:50:53 INFO - mozversion platform_changeset: 942d7567e119d48bd129f2850fabe2dd687a0476 10:50:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:50:53 INFO - mozversion platform_version: 49.0 10:50:53 INFO - using testdate: 1470333053 10:50:53 INFO - actual date: 1470333053 10:50:53 INFO - starting webserver on 'localhost:34265' 10:50:53 INFO - SUITE-START | Running 2 tests 10:50:53 INFO - TEST-START | dromaeo_css 10:50:53 INFO - operating with platform_type : linux_ 10:50:53 INFO - Initialising browser for dromaeo_css test... 10:50:53 INFO - TEST-INFO | started process 10046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTZzPLM/profile http://localhost:34265/getInfo.html) 10:50:57 INFO - PROCESS | 10046 | __metrics Screen width/height:1600/1200 10:50:57 INFO - PROCESS | 10046 | colorDepth:24 10:50:57 INFO - PROCESS | 10046 | Browser inner width/height: 1024/697 10:50:57 INFO - PROCESS | 10046 | __metrics 10:50:57 ERROR - PROCESS | 10046 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:50:58 INFO - TEST-INFO | 10046: exit 0 10:50:58 INFO - Browser initialized. 10:50:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:50:58 INFO - TEST-INFO | started process 10176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTZzPLM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:51:10 INFO - PROCESS | 10176 | RSS: Main: 152768512 10:51:10 INFO - PROCESS | 10176 | 10:52:00 INFO - PROCESS | 10176 | 1470333120149 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] 10:54:08 INFO - PROCESS | 10176 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34265/tests/dromaeo/cssquery-ext.html) 10:54:09 INFO - PROCESS | 10176 | RSS: Main: 156688384 10:54:09 INFO - PROCESS | 10176 | 10:57:11 INFO - PROCESS | 10176 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-ext.html (next: http://localhost:34265/tests/dromaeo/cssquery-jquery.html) 10:57:12 INFO - PROCESS | 10176 | RSS: Main: 155045888 10:57:12 INFO - PROCESS | 10176 | 11:00:13 INFO - PROCESS | 10176 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34265/tests/dromaeo/cssquery-mootools.html) 11:00:14 INFO - PROCESS | 10176 | RSS: Main: 154382336 11:00:14 INFO - PROCESS | 10176 | 11:03:16 INFO - PROCESS | 10176 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34265/tests/dromaeo/cssquery-prototype.html) 11:03:16 INFO - PROCESS | 10176 | RSS: Main: 155623424 11:03:16 INFO - PROCESS | 10176 | 11:06:19 INFO - PROCESS | 10176 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34265/tests/dromaeo/cssquery-yui.html) 11:06:19 INFO - PROCESS | 10176 | RSS: Main: 154116096 11:06:19 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | Cycle 1(1): loaded http://localhost:34265/tests/dromaeo/cssquery-yui.html (next: http://localhost:34265/tests/dromaeo/cssquery-dojo.html) 11:09:22 INFO - PROCESS | 10176 | RSS: Main: 158289920 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | __start_tp_report 11:09:22 INFO - PROCESS | 10176 | _x_x_mozilla_page_load 11:09:22 INFO - PROCESS | 10176 | _x_x_mozilla_page_load_details 11:09:22 INFO - PROCESS | 10176 | |i|pagename|runs| 11:09:22 INFO - PROCESS | 10176 | |0;dojo.html;3406.9829650851743;3418.5384973028636;3424.5376874121994;3443.4146195146836;3450.413429716948;5640.520555752761;5687.345955215152;5703.03048481758;5719.542436605072;5738.483536481715;5680.744366503507;5684.204211410395;5747.683877386742;5748.080307150857;5754.309482862052;5133.127368347381;5183.766730497118;5227.581793456515;5260.158374660055;5272.393674727398;5107.565856902149;5167.173252279636;5268.525832675058;5272;5272.314599102111;5185.637005409604;5221.973890130544;5222;5242.842714718565;5256.316678831766;5173.5861131109605;5180.326557547513;5230.163173892197;5232.032074066272;5246.737663116829;5123.641345105844;5144.922826157611;5233.058049551118;5238.895222095537;5264.210368444764;5437.564994800407;5555.111182210827;5591.496765291103;5653.349864765563;5694.060480020791;6228.564000519966;6247.468965137969;6267.2479302484;6267.561270711052;6269.404406581368;6031.879362412771;6267.279262884781;6301.621902685808;6308.779192728279;6313.463355614732;5770.624909380919;5779.450952159538;5819.476247137778;5877.5591830612875;5881.323647780475;6392.328805475451;6421.743130274736;6425.1968503937005;6426.485881129498;6450.354964503512;5859.824205273849;6010.519158467312;6133.938660613337;6146.078088286793;6183.536234782319;6094.45149936499;6198.659073750897;6212.47193988516;6224.62652240867;6233.407826256498;6191.133241346125;6199.194104766351;6202.317745048041;6213.161223234896;6225.470834979077;5912.674802885796;6076.939230607726;6079.604825686316;6205.937940620536;6208.658523781235;4685.6017238535105;4704.623630109583;4707.7881495332795;4712.363830882856;4740.691855029412;4204.222218889515;4207.431996680471;4227.429297044921;4249.532551419341;4253.787310634456;5857.47282744555;5970.940290597126;5974.4324289192455;5999.250093738283;6019.969900150471;6005.099235114768;6021.187139736079;6078.60489068218;6132.448079672851;6141.6007959482495;5876.676782776988;5895.263092113486;5932.317783454958;5942.049272116441;5972.193753843262;5297.073012222922;5369.812056578079;5370.2213179089595;5371.3822910365025;5378.596605254622;6190.040543715641;6389.808305750835;6392.904106438407;6429.260635026938;6543.738250469928;6271.31015588294;6284.591501552384;6300.243970723543;6301.243850737849;6319.778807741891;6323.620582765049;6482.675866206765;6553.2136143663065;6564.671766411565;6571.901421478778;6090.725917333819;6111.7249723763425;6140.785072522441;6142.055645205473;6186.938130618636;6248.968755156195;6252.187215662117;6280.780172693934;6287.748490060347;6303.590266632654;5887.970560147171;6023.036314189709;6046.395360464095;6064.4541991221;6064.969675151596;6030;6088;6093.969530152321;6099.542534309856;6123.112148738497;5988.6706231157705;6046.7278972445465;6058.697065146637;6065.2418447694035;6068.423499767515;5943.613665111927;5944.286685597756;5967.254093238345;6102.237220347457;6130.570860039755;5918.911216331672;5919.348871624032;5937.050071988461;5938.138969849434;5982.970085149546 11:09:22 INFO - PROCESS | 10176 | |1;ext.html;584.4330998931038;642.8360768004159;651.7490766055071;664.8204984654145;681.1043477826661;41567;45961.31058034132;46380.07239855205;46464.76767616157;46512.767436162816;45724.314135288;46297.537024629746;46310.305345419845;46521;46616.53383466164;8886.82226355474;9018.323625728064;9074.682386116487;9082.77293067672;9100.044495327995;9019.819603607924;9062.954685226598;9080.455172689659;9084.454932704026;9106.63573457061;9120.31597630177;9141.268698504104;9153.176214140725;9159.084091590854;9186.081391860827;9027.503487308195;9066.184043436122;9068.546572671374;9072.954635226848;9096.181343679034;9025.097490250988;9052.547372631341;9053.728388148365;9071.773205669844;9085.545722713838;43174.78412607917;43467.34798978018;43483;43538;43743.56256437459;3712.1647629283466;3806.219724956405;3808.828602712857;3934.449177115206;4229.386738922839;34024.14939626529;34449;34541.654583454096;34828.30343393118;34971;4662.930056049128;4683.836065737717;4699.154152252593;4776.379070720819;4781.0676918001;361572;361691;362003;364328;365755;38409.615903840604;65525;65592.67203664046;65907;66084.33915660878;39099.41350879739;40240.59759402427;40640;40723;40801.591984080376;14593.927030364992;14824.03643763152;14852;14873.776893346609;14898.702025959421;11574.6527604172;11865.525378984916;11884.702882428008;11891.821622675667;11921.582744604071;9233.907660923305;9235.168834804765;9257.398269112486;9294.535273236312;9298.86051709225;3543.557055368079;3558.1104723819044;3596.1009747563107;3600.3879340512176;3605.8725352041897;1016.5832008876473;1100.4002818463957;1132.8583927009124;1145.2441388683428;1154.9826752598717;30779.23051923675;34177.316453670785;37120.01436401796;37242.8137859309;37776.055598610255;1149.2587281203744;1159.9362035088152;1236.4003458322707;1238.139493052338;1247.3451437995125;17243;17331.30674772995;17573;17618.735718964224;17676.02781847011;572946;577741;577939;578125;578254;62338.68830655908;63072.68463657652;63281.36718632847;63487.36512634907;63765.04352434717;1502.721996430664;1524.809398825147;1527.618095476131;1537.3927298717167;1537.9000364976241;32143.678563214067;32864.835675822425;33176.1705957353;33225.833870830495;33637.99086027423;56985.715071424376;57665;57683.1347529779;57811;57964.13053804281;526565;526629;528140;528162;529194;30779.692203077684;30871.84564077165;31242.21894452657;31910.36179276355;32154.83922580372;52487;53593.19610205928;53640.73179634077;54033.18950215828;55120.72439637776;45420;45565.31652025288;45695.086098277185;46759.29861052019;47430.76284618555;44572;44671.10657786891;45568.316475252235;45575;46958.76520617375;43451;44163;44628.10743785171;45443;48373.75813120912;39914;40108.197836042535;40112.1977560453;40117.39823902585;40971.59028409797;30217.64535493434;30427.695723043373;30574.694253057183;30652.693473064985;30786.230344241572 11:09:22 INFO - PROCESS | 10176 | |2;jquery.html;421.7764584770073;422.15358206795406;431.6503632058032;433.25696430621485;443.3195045604995;18672.62654746906;19812.60374792505;20417.28539501118;20890.164393424282;20904.26835060773;18155;18400.723989140173;18562.257509699597;18630.53423664409;18766.43700688978;5600.635958662694;5759.712014399284;5814.273215848019;5817.214676018747;5818;5505.834824955237;5754.223179870705;5856.824295271127;5870.559708021916;5918.970405147989;5907.409259074079;5915.349311575723;5931.614445061079;6528.41244288014;6692.83267918301;6613.008048792672;6667.599944003376;6684.298148694365;6706.9329306706795;6722.025306330579;5758.827235182951;5892.882142357172;5894.381089985575;5897.557683173779;5908.084246941731;13561.321933903266;13972.790408143886;19532.511687207792;23512.64731029036;23712.170074047324;2328.569214695287;2332.2420213430532;2347.2254156128606;2393.904243830245;2614.9215523534326;10476.68569942903;10922.29005114665;11003.779924401468;13025.153365031243;14519;1948.7953764854628;2052.107333310015;2098.3495116513777;2133.157402825875;2134.647783115784;82208.17791822125;83026;84194.57902710508;86539.99999999937;86552;11308;11573.826392604118;11730.941345293219;11754.11844111695;11890.16768826174;16730.330786768394;16738.330466781437;16839.831601684073;16841.57896052584;16907.408240711517;7786.649600767979;8291;8292.58537073144;8497.320214382835;8777.078406767325;7899.973003509507;7900.091489478668;7959.522428654183;7993.9200607994335;7994.880076798852;4177.4569305990635;4503.144402563568;5087.465816089331;5192.4547922468355;5200.193969934666;2040.7449068866392;2068.8965551722654;2097.0144032304793;2143.7641859395453;2144.142343062756;972.9075737804898;1004.1916257412706;1018.2159737002466;1087.6138970665459;1100.565276715709;18781.624367512573;19607.90196049039;19657.41027769169;19805.504862378555;19854.1065652046;1049.0925349572565;1058.3015209961388;1083.7615724540588;1097.1332647208617;1103.3545375954996;10714.303570267908;11085.722856928642;11151;11151.219414640897;11154.832677509843;477716;487690;507282;508752;509813;94873.5256323714;95980.52009740047;97153;98491;98782;503.509078648315;514.9897002059938;515.4845154845154;516.2565905096724;517.1441264706916;10897.346159230154;11415.258008229439;11571.826422603499;11733.647990560297;11741.11941604366;40513.39229911612;42548;44013;44081;44352;58312.70843645755;59830.40169598248;59897;60667.69666151641;60827;8695.391322607356;8896.243819275434;8897.555122243992;9253;9361.906380936103;10018.448985305879;12951.935240323737;13448.46206151743;13473.056886017885;14013.159210446998;12204.755904881675;12336.444859981502;12349.691257718629;12390.62828115158;12531.060170487068;11115.577191232576;12366.970092327438;12384.56654017105;12392.442340094538;12713.682157946125;12373.690657733268;12393.442295096922;12421.31682757457;12516.93741531323;12630.115891887479;9064.456132632064;9076.410033348075;9131.406458580172;9183.678571249975;9491.715248542554;9130.863037054316;11761.47073381717;12118.333491658044;12128.696782580153;12191.878081219429 11:09:22 INFO - PROCESS | 10176 | |3;mootools.html;1577.4005877766451;1607.3570571771293;1837.4212123181196;1948.3278268997192;1962.3720409468967;8114.594270286477;9017.819643607125;9052.140046695562;9537.713868583945;9622.56698448569;9144.177024067849;9408.81182376352;9430.622775088988;9442.150206481416;9449.480278584675;2456.877156142199;2489.9542192279196;2505.7744802967727;2505.9749402506013;2513.3088400689867;2380.9642855357183;2478.876056197192;2497.425592113815;2501.7123030851412;2503.086373473687;2436.317831007321;2437.317551085699;2471.641611966264;2475.6905386826647;2480.293116461809;2421.903123875043;2443.816713746476;2451.0563433078214;2465.8890349934295;2475.232677869866;2385.594448943684;2406.3984003999;2406.554787364343;2421.5883299838893;2421.782039616443;9432.622695092188;9469.195118414944;9491.477968711788;9502.809943801154;9517.23862091038;5370.865728356784;5568.387477377485;5578.9163162552595;5583.441655834384;5600.803971861006;3399.9490007649906;3464.9826750866337;3531.1172206948263;3536.752427330088;3570.928581428383;1118.530217308724;1128.5147386623748;1158.6176561734692;1168.4858662188694;1199.1366216324232;13294.933525332312;13340.399682014333;13344.065915385927;13348.466061357534;13372.398242079129;4794.736289504111;4817.927731084036;4819.180739274332;4851.175300198904;4915.18899381598;11039.448027598588;11175.83236251457;11204.49579768896;11208.831867521994;11223.55105795759;5503.229547863302;5514.448555144453;5552.555795536347;5559.971405290034;5565.888682226414;4463.486699029589;4954.77703503336;5071.41678706946;5112.054269960069;5113.795448182031;4315.438992930899;4331.675124365685;4367.323064924942;4372.103718737651;4395.7142785718825;1281.2120545864414;1341.121565374681;1343.9798403023963;1358.3547814788094;1379.5723325769043;988.3180605382263;1026.4046852825343;1122.2480937771713;1143.519721716881;1145.0438883532345;6622.9006564901565;6739.359760822714;6802.897956530656;6859.039734437183;6864.7940561783225;493.5286801104936;510.36969342861534;512.4209643103344;513.7765072193607;518.4815184815185;4523.072770082125;4580.473245576802;4602.861914142581;4643.907121857544;4665.090307390026;11147.665570032912;11597.18819682614;11955.820662689892;11958.282503049844;11983.34091624969;11728.179027468166;11767.88232117685;11776.11679124069;11819.940900295616;11849.111316651286;8468.195521425454;8585.184407481403;8601.698940537051;8631.266342360845;8641.956790216009;6225.968870155621;6288.506268085689;6415.743370265137;6457.773977910751;6529.608223506605;9722.833260008843;9890.357126786736;9902.108810207115;9924.15644670211;10036.397816131055;10047.899521004696;10111.54498047575;10186.694399168036;10201.642942497274;10215.897841021495;7682.884756728542;7761;7914;8387.287080598218;8424.283935865275;9244.630214791601;9268.258539316974;9273.76815579589;9351.158395744416;9366.81266374655;8088.87866682012;8319.916800831914;8391.832163356821;8548.572571371531;8553.401261911606;7702.345300649507;7823.491473054233;7976.561289129154;7992.200779922194;8179.141190174946;7632.236776322324;7654.8086297843;7736.1877002916135;7813.921860781319;7822.804429889298;5600.57995650336;5707.1153971134545;5719.628224165416;5749.8787736391005;5855.765769369177;5259.21111833228;5269.920951185812;5287.603429742708;5313.814016509404;5351.224072509543 11:09:22 INFO - PROCESS | 10176 | |4;prototype.html;328.83535855701587;340.87387666563376;341.2288228603356;344.748333716387;352.56106147845935;5679.744411501482;5722.855428914213;5770.538356931446;5778.27771528559;5822.592418530699;5634.4365563443735;5637.267155269809;5649.943500565003;5659.66042037478;5661.66030038198;4393.846215382462;4430.556944305576;4432.822687092513;4434.467863856342;4436.223660859337;4232.446771517429;4408.669349798762;4437.733735975836;4443.37792709021;4448.310511870665;4399.604035636792;4408.14041261954;4412.338149277618;4415.580519850609;4425.424694789689;4402.7578483183415;4414.271645178542;4424.654932885575;4436.136822534543;4450.755208463534;3745.9625403745886;3918.5689574146822;3929.155231625214;3956.683465322796;3957;5496.258005169291;5512.724363781795;5516.9448305516835;5538.6122971392015;5577.386487486373;5142.254373115915;5167.534921857014;5175.327207463043;5177.508136727005;5180.119379705459;5860.765569377219;6006.699665016732;6028.216331876872;6044.758209671608;6045.788397406113;4409.11817636474;4411.691181617288;4412.316091005867;4417.447819022622;4432.667549933735;6142.6007309525185;6302.243730752339;6320;6365.0904728581245;6370.203724534434;4466.977665111719;4474.731516109044;4477.910441791211;4500.774961251925;4517.5482451755215;4540.182767101887;4542.454905411306;4559.589636932692;4576.153411618861;4608.400907881954;5146.639735218499;5154.098032844237;5172.560332371715;5190.584753219733;5197.454267301954;5801.824315881545;5840.8247752567495;5995.130706047686;6066.211392519032;6135.570510064342;1558.3610719604908;1574.2600977540537;1575.9763603545955;1576.172509432534;1583.22422013215;1011.8279892418159;1011.8785745710414;1012.2762225009154;1018.4195008844887;1045.3153184664056;5222.738863056832;5268.315119034578;5294.7617357219015;5295.232191332312;5305.920411193835;5506.64206826555;5508.366537848118;5509.044289277329;5512.5314348280845;5538.833834984957;4909;5226.491284183613;5271.604629652791;5299.549538289289;5318.468153184728;2926.5610158475974;2932.560115982577;2938.9713600239743;2950.704929507075;2964.273752930546;5695.380125142398;5725.456081672234;5736.680563470425;5760.42395760429;5770.855728606734;6042.425969532887;6423.935760642427;6445.838854028593;6463.547551671432;6478.060681201199;6539.836504087436;6552.541322107407;6553.279139294674;6571.67141642916;6615.801525954229;6007.897235967376;6179.814605561661;6196.845078872884;6237.719302631302;6285.49716022708;6095;6140.1710769047395;6193.473554747897;6195.535334849814;6198.0785956353675;6281.434670879643;6438.679595503497;6477.805665830033;6496.642684652389;6542.54202205841;4296.656267498655;4304.332828411601;4331.566843315769;4343.739375637472;4349.412829268135;6065.636061836304;6262.561620686508;6292.496600271876;6322.841928951813;6332.841678957879;6055.576109672281;6059.969700151471;6091.7563297467605;6105.48103411215;6113.969430152821;6082.665453400105;6085.208922840179;6101.694915254131;6109.31190276277;6116.847078823065;5768.971155144198;6008.459238668541;6021.969890150521;6027.126066720213;6027.517798576016;6123.755049797958;6124.448799608057;6142.170806941006;6148;6150.292716337678;5781;5982.730777115127;5990.131430942576;6031.457168854824;6052.727627256696 11:09:22 INFO - PROCESS | 10176 | |5;yui.html;801.7634797734671;823.7775800533856;854.5641722721413;874.4447275979755;912.2154946745802;14779.630509237275;14794.408223671067;14880.330385132667;15202.619934501643;15645.687086258282;14845.851541484582;15108.47120350788;15192.164430956293;15373.615659608515;15441.305141268642;866.679328648401;914.3599480363739;919.7746552094746;920.9815803683922;922.1516205091299;897.4839467306292;897.7396554999042;903.5708038681639;904.3036861616584;905.0316161706976;938.1650331205233;944.4427787605312;947.2327414794005;948.928830337724;951.281782254397;945.1493655709847;946.129560804062;946.4841661294611;948.231932134966;951.4481600671628;692.4564217089611;694.9583025018516;695.1415002471944;695.1935754524727;697.0206859362604;15245;15272.618184545365;15282.465113721077;15320.923395383063;15327.386904523806;15714.528564143095;15860.127692976881;15912.443064492687;15944.920275398548;15994.920025399799;12527.123101382907;12557.74884502314;12568.120231583793;12859.549915752903;12921.289329086896;4160.729552579072;4162.937555936664;4179.310413781723;4187.120704652027;4226.049138943744;79926.20073799304;79960;80092.19907800906;80457;81032.59483702603;12037.759244815055;12513.624591262094;12600.4329805159;12630.747385052431;12643.241405515699;24054.278371648878;24091;24095.156669516484;24135.15526956548;24247.515049698908;9034.954825225963;9064.410813297247;9199.862002069975;9286.860697089549;9325.626974920928;5161.148410512298;5190.8183213587345;5329.840104796862;5337.973310133424;5436.130219164994;3963.7819919904105;4134.255833949918;4136.503619565671;4139.110091330378;4142.212979533879;678.0710426715333;690.3648643248224;709.0994437064899;711.8184862860041;732.3847967707152;642.6047980491963;772.7449941519285;780.8126049748133;828.6685325869701;834.7913021744564;10797.83803242952;10914.508847101899;10925.945370273257;10937.83593246102;10982.670519884416;661.8775526527608;718.9653281214152;744.5383862005591;747.4506237915128;757.6742000939539;4855.247436647325;5003.7998480061115;5032.7735251913755;5043.52086551777;5072.82245121419;76233;76788;121081;122295;124773;75838;88531;108396.4580177094;110784;112615.4369228165;75792;98535.9884192351;99569.50215248877;100005;101232.49383753035;8537.615807288812;9136.497492637704;9826.4104153751;9836.213102951604;9900.554475048497;54622.726886365315;55200;56960.145597816896;57676.71161644165;58925.41074589199;78382.60808696148;79906.60046699729;80249.19750802651;80528.59735701284;81134.59432702798;12836;13193.406296716863;13232.603021909357;13380;13915.234662093682;14125.364358603681;14824.725715814962;14954.775678365051;15215;15299;13653.726925461633;13834;13875;13906.304684765924;13990;13555.661108472366;13734.519291824738;13742.381592828548;14076.085054471427;14169.29153542298;12345.444454999726;13054.804177937529;13154.736905262032;13355;13450;9853.655122070693;10811;10949.671509854717;11376.488058037243;11637.301761894314;12106.939465302617;12285.69285767863;12799.488020479077;12828.615141545768;13073.607791766262 11:09:22 INFO - PROCESS | 10176 | __end_tp_report 11:09:22 INFO - PROCESS | 10176 | __start_cc_report 11:09:22 INFO - PROCESS | 10176 | _x_x_mozilla_cycle_collect,333 11:09:22 INFO - PROCESS | 10176 | __end_cc_report 11:09:22 INFO - PROCESS | 10176 | __startTimestamp1470334162308__endTimestamp 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | ------- Summary: start ------- 11:09:22 INFO - PROCESS | 10176 | Number of tests: 6 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | [#0] dojo.html Cycles:165 Average:5750.90 Median:5974.43 stddev:661.46 (11.1%) stddev-sans-first:637.42 11:09:22 INFO - PROCESS | 10176 | Values: 3407.0 3418.5 3424.5 3443.4 3450.4 5640.5 5687.3 5703.0 5719.5 5738.5 5680.7 5684.2 5747.7 5748.1 5754.3 5133.1 5183.8 5227.6 5260.2 5272.4 5107.6 5167.2 5268.5 5272.0 5272.3 5185.6 5222.0 5222.0 5242.8 5256.3 5173.6 5180.3 5230.2 5232.0 5246.7 5123.6 5144.9 5233.1 5238.9 5264.2 5437.6 5555.1 5591.5 5653.3 5694.1 6228.6 6247.5 6267.2 6267.6 6269.4 6031.9 6267.3 6301.6 6308.8 6313.5 5770.6 5779.5 5819.5 5877.6 5881.3 6392.3 6421.7 6425.2 6426.5 6450.4 5859.8 6010.5 6133.9 6146.1 6183.5 6094.5 6198.7 6212.5 6224.6 6233.4 6191.1 6199.2 6202.3 6213.2 6225.5 5912.7 6076.9 6079.6 6205.9 6208.7 4685.6 4704.6 4707.8 4712.4 4740.7 4204.2 4207.4 4227.4 4249.5 4253.8 5857.5 5970.9 5974.4 5999.3 6020.0 6005.1 6021.2 6078.6 6132.4 6141.6 5876.7 5895.3 5932.3 5942.0 5972.2 5297.1 5369.8 5370.2 5371.4 5378.6 6190.0 6389.8 6392.9 6429.3 6543.7 6271.3 6284.6 6300.2 6301.2 6319.8 6323.6 6482.7 6553.2 6564.7 6571.9 6090.7 6111.7 6140.8 6142.1 6186.9 6249.0 6252.2 6280.8 6287.7 6303.6 5888.0 6023.0 6046.4 6064.5 6065.0 6030.0 6088.0 6094.0 6099.5 6123.1 5988.7 6046.7 6058.7 6065.2 6068.4 5943.6 5944.3 5967.3 6102.2 6130.6 5918.9 5919.3 5937.1 5938.1 5983.0 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | [#1] ext.html Cycles:180 Average:64878.37 Median:44649.61 stddev:132442.43 (296.6%) stddev-sans-first:132725.99 11:09:22 INFO - PROCESS | 10176 | Values: 584.4 642.8 651.7 664.8 681.1 41567.0 45961.3 46380.1 46464.8 46512.8 45724.3 46297.5 46310.3 46521.0 46616.5 8886.8 9018.3 9074.7 9082.8 9100.0 9019.8 9063.0 9080.5 9084.5 9106.6 9120.3 9141.3 9153.2 9159.1 9186.1 9027.5 9066.2 9068.5 9073.0 9096.2 9025.1 9052.5 9053.7 9071.8 9085.5 43174.8 43467.3 43483.0 43538.0 43743.6 3712.2 3806.2 3808.8 3934.4 4229.4 34024.1 34449.0 34541.7 34828.3 34971.0 4662.9 4683.8 4699.2 4776.4 4781.1 361572.0 361691.0 362003.0 364328.0 365755.0 38409.6 65525.0 65592.7 65907.0 66084.3 39099.4 40240.6 40640.0 40723.0 40801.6 14593.9 14824.0 14852.0 14873.8 14898.7 11574.7 11865.5 11884.7 11891.8 11921.6 9233.9 9235.2 9257.4 9294.5 9298.9 3543.6 3558.1 3596.1 3600.4 3605.9 1016.6 1100.4 1132.9 1145.2 1155.0 30779.2 34177.3 37120.0 37242.8 37776.1 1149.3 1159.9 1236.4 1238.1 1247.3 17243.0 17331.3 17573.0 17618.7 17676.0 572946.0 577741.0 577939.0 578125.0 578254.0 62338.7 63072.7 63281.4 63487.4 63765.0 1502.7 1524.8 1527.6 1537.4 1537.9 32143.7 32864.8 33176.2 33225.8 33638.0 56985.7 57665.0 57683.1 57811.0 57964.1 526565.0 526629.0 528140.0 528162.0 529194.0 30779.7 30871.8 31242.2 31910.4 32154.8 52487.0 53593.2 53640.7 54033.2 55120.7 45420.0 45565.3 45695.1 46759.3 47430.8 44572.0 44671.1 45568.3 45575.0 46958.8 43451.0 44163.0 44628.1 45443.0 48373.8 39914.0 40108.2 40112.2 40117.4 40971.6 30217.6 30427.7 30574.7 30652.7 30786.2 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | [#2] jquery.html Cycles:180 Average:29537.54 Median:13053.04 stddev:82325.76 (630.7%) stddev-sans-first:82527.68 11:09:22 INFO - PROCESS | 10176 | Values: 421.8 422.2 431.7 433.3 443.3 18672.6 19812.6 20417.3 20890.2 20904.3 18155.0 18400.7 18562.3 18630.5 18766.4 5600.6 5759.7 5814.3 5817.2 5818.0 5505.8 5754.2 5856.8 5870.6 5919.0 5907.4 5915.3 5931.6 6528.4 6692.8 6613.0 6667.6 6684.3 6706.9 6722.0 5758.8 5892.9 5894.4 5897.6 5908.1 13561.3 13972.8 19532.5 23512.6 23712.2 2328.6 2332.2 2347.2 2393.9 2614.9 10476.7 10922.3 11003.8 13025.2 14519.0 1948.8 2052.1 2098.3 2133.2 2134.6 82208.2 83026.0 84194.6 86540.0 86552.0 11308.0 11573.8 11730.9 11754.1 11890.2 16730.3 16738.3 16839.8 16841.6 16907.4 7786.6 8291.0 8292.6 8497.3 8777.1 7900.0 7900.1 7959.5 7993.9 7994.9 4177.5 4503.1 5087.5 5192.5 5200.2 2040.7 2068.9 2097.0 2143.8 2144.1 972.9 1004.2 1018.2 1087.6 1100.6 18781.6 19607.9 19657.4 19805.5 19854.1 1049.1 1058.3 1083.8 1097.1 1103.4 10714.3 11085.7 11151.0 11151.2 11154.8 477716.0 487690.0 507282.0 508752.0 509813.0 94873.5 95980.5 97153.0 98491.0 98782.0 503.5 515.0 515.5 516.3 517.1 10897.3 11415.3 11571.8 11733.6 11741.1 40513.4 42548.0 44013.0 44081.0 44352.0 58312.7 59830.4 59897.0 60667.7 60827.0 8695.4 8896.2 8897.6 9253.0 9361.9 10018.4 12951.9 13448.5 13473.1 14013.2 12204.8 12336.4 12349.7 12390.6 12531.1 11115.6 12367.0 12384.6 12392.4 12713.7 12373.7 12393.4 12421.3 12516.9 12630.1 9064.5 9076.4 9131.4 9183.7 9491.7 9130.9 11761.5 12118.3 12128.7 12191.9 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | [#3] mootools.html Cycles:180 Average:6156.68 Median:2704.36 stddev:3511.22 (129.8%) stddev-sans-first:3504.20 11:09:22 INFO - PROCESS | 10176 | Values: 1577.4 1607.4 1837.4 1948.3 1962.4 8114.6 9017.8 9052.1 9537.7 9622.6 9144.2 9408.8 9430.6 9442.2 9449.5 2456.9 2490.0 2505.8 2506.0 2513.3 2381.0 2478.9 2497.4 2501.7 2503.1 2436.3 2437.3 2471.6 2475.7 2480.3 2421.9 2443.8 2451.1 2465.9 2475.2 2385.6 2406.4 2406.6 2421.6 2421.8 9432.6 9469.2 9491.5 9502.8 9517.2 5370.9 5568.4 5578.9 5583.4 5600.8 3399.9 3465.0 3531.1 3536.8 3570.9 1118.5 1128.5 1158.6 1168.5 1199.1 13294.9 13340.4 13344.1 13348.5 13372.4 4794.7 4817.9 4819.2 4851.2 4915.2 11039.4 11175.8 11204.5 11208.8 11223.6 5503.2 5514.4 5552.6 5560.0 5565.9 4463.5 4954.8 5071.4 5112.1 5113.8 4315.4 4331.7 4367.3 4372.1 4395.7 1281.2 1341.1 1344.0 1358.4 1379.6 988.3 1026.4 1122.2 1143.5 1145.0 6622.9 6739.4 6802.9 6859.0 6864.8 493.5 510.4 512.4 513.8 518.5 4523.1 4580.5 4602.9 4643.9 4665.1 11147.7 11597.2 11955.8 11958.3 11983.3 11728.2 11767.9 11776.1 11819.9 11849.1 8468.2 8585.2 8601.7 8631.3 8642.0 6226.0 6288.5 6415.7 6457.8 6529.6 9722.8 9890.4 9902.1 9924.2 10036.4 10047.9 10111.5 10186.7 10201.6 10215.9 7682.9 7761.0 7914.0 8387.3 8424.3 9244.6 9268.3 9273.8 9351.2 9366.8 8088.9 8319.9 8391.8 8548.6 8553.4 7702.3 7823.5 7976.6 7992.2 8179.1 7632.2 7654.8 7736.2 7813.9 7822.8 5600.6 5707.1 5719.6 5749.9 5855.8 5259.2 5269.9 5287.6 5313.8 5351.2 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | [#4] prototype.html Cycles:180 Average:5020.87 Median:5514.83 stddev:1491.75 (27.0%) stddev-sans-first:1453.77 11:09:22 INFO - PROCESS | 10176 | Values: 328.8 340.9 341.2 344.7 352.6 5679.7 5722.9 5770.5 5778.3 5822.6 5634.4 5637.3 5649.9 5659.7 5661.7 4393.8 4430.6 4432.8 4434.5 4436.2 4232.4 4408.7 4437.7 4443.4 4448.3 4399.6 4408.1 4412.3 4415.6 4425.4 4402.8 4414.3 4424.7 4436.1 4450.8 3746.0 3918.6 3929.2 3956.7 3957.0 5496.3 5512.7 5516.9 5538.6 5577.4 5142.3 5167.5 5175.3 5177.5 5180.1 5860.8 6006.7 6028.2 6044.8 6045.8 4409.1 4411.7 4412.3 4417.4 4432.7 6142.6 6302.2 6320.0 6365.1 6370.2 4467.0 4474.7 4477.9 4500.8 4517.5 4540.2 4542.5 4559.6 4576.2 4608.4 5146.6 5154.1 5172.6 5190.6 5197.5 5801.8 5840.8 5995.1 6066.2 6135.6 1558.4 1574.3 1576.0 1576.2 1583.2 1011.8 1011.9 1012.3 1018.4 1045.3 5222.7 5268.3 5294.8 5295.2 5305.9 5506.6 5508.4 5509.0 5512.5 5538.8 4909.0 5226.5 5271.6 5299.5 5318.5 2926.6 2932.6 2939.0 2950.7 2964.3 5695.4 5725.5 5736.7 5760.4 5770.9 6042.4 6423.9 6445.8 6463.5 6478.1 6539.8 6552.5 6553.3 6571.7 6615.8 6007.9 6179.8 6196.8 6237.7 6285.5 6095.0 6140.2 6193.5 6195.5 6198.1 6281.4 6438.7 6477.8 6496.6 6542.5 4296.7 4304.3 4331.6 4343.7 4349.4 6065.6 6262.6 6292.5 6322.8 6332.8 6055.6 6060.0 6091.8 6105.5 6114.0 6082.7 6085.2 6101.7 6109.3 6116.8 5769.0 6008.5 6022.0 6027.1 6027.5 6123.8 6124.4 6142.2 6148.0 6150.3 5781.0 5982.7 5990.1 6031.5 6052.7 11:09:22 INFO - PROCESS | 10176 | 11:09:22 INFO - PROCESS | 10176 | [#5] yui.html Cycles:180 Average:21508.99 Median:4206.58 stddev:30561.63 (726.5%) stddev-sans-first:30607.81 11:09:22 INFO - PROCESS | 10176 | Values: 801.8 823.8 854.6 874.4 912.2 14779.6 14794.4 14880.3 15202.6 15645.7 14845.9 15108.5 15192.2 15373.6 15441.3 866.7 914.4 919.8 921.0 922.2 897.5 897.7 903.6 904.3 905.0 938.2 944.4 947.2 948.9 951.3 945.1 946.1 946.5 948.2 951.4 692.5 695.0 695.1 695.2 697.0 15245.0 15272.6 15282.5 15320.9 15327.4 15714.5 15860.1 15912.4 15944.9 15994.9 12527.1 12557.7 12568.1 12859.5 12921.3 4160.7 4162.9 4179.3 4187.1 4226.0 79926.2 79960.0 80092.2 80457.0 81032.6 12037.8 12513.6 12600.4 12630.7 12643.2 24054.3 24091.0 24095.2 24135.2 24247.5 9035.0 9064.4 9199.9 9286.9 9325.6 5161.1 5190.8 5329.8 5338.0 5436.1 3963.8 4134.3 4136.5 4139.1 4142.2 678.1 690.4 709.1 711.8 732.4 642.6 772.7 780.8 828.7 834.8 10797.8 10914.5 10925.9 10937.8 10982.7 661.9 719.0 744.5 747.5 757.7 4855.2 5003.8 5032.8 5043.5 5072.8 76233.0 76788.0 121081.0 122295.0 124773.0 75838.0 88531.0 108396.5 110784.0 112615.4 75792.0 98536.0 99569.5 100005.0 101232.5 8537.6 9136.5 9826.4 9836.2 9900.6 54622.7 55200.0 56960.1 57676.7 58925.4 78382.6 79906.6 80249.2 80528.6 81134.6 12836.0 13193.4 13232.6 13380.0 13915.2 14125.4 14824.7 14954.8 15215.0 15299.0 13653.7 13834.0 13875.0 13906.3 13990.0 13555.7 13734.5 13742.4 14076.1 14169.3 12345.4 13054.8 13154.7 13355.0 13450.0 9853.7 10811.0 10949.7 11376.5 11637.3 12106.9 12285.7 12799.5 12828.6 13073.6 11:09:22 INFO - PROCESS | 10176 | -------- Summary: end -------- 11:09:22 INFO - PROCESS | 10176 | 11:09:23 INFO - TEST-INFO | 10176: exit 0 11:09:23 INFO - TEST-OK | dromaeo_css | took 1110025ms 11:09:23 INFO - TEST-START | kraken 11:09:23 INFO - operating with platform_type : linux_ 11:09:23 INFO - Initialising browser for kraken test... 11:09:23 INFO - TEST-INFO | started process 10419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp17ij4u/profile http://localhost:34265/getInfo.html) 11:09:27 INFO - PROCESS | 10419 | __metrics Screen width/height:1600/1200 11:09:27 INFO - PROCESS | 10419 | colorDepth:24 11:09:27 INFO - PROCESS | 10419 | Browser inner width/height: 1024/697 11:09:27 INFO - PROCESS | 10419 | __metrics 11:09:27 ERROR - PROCESS | 10419 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:09:28 INFO - TEST-INFO | 10419: exit 0 11:09:28 INFO - Browser initialized. 11:09:28 INFO - Running cycle 1/1 for kraken test... 11:09:28 INFO - TEST-INFO | started process 10547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp17ij4u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:40 INFO - PROCESS | 10547 | RSS: Main: 153071616 11:09:40 INFO - PROCESS | 10547 | 11:09:42 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:43 INFO - PROCESS | 10547 | RSS: Main: 158408704 11:09:43 INFO - PROCESS | 10547 | 11:09:46 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-dft) 11:09:47 INFO - PROCESS | 10547 | RSS: Main: 156983296 11:09:47 INFO - PROCESS | 10547 | 11:09:49 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-fft) 11:09:50 INFO - PROCESS | 10547 | RSS: Main: 158175232 11:09:50 INFO - PROCESS | 10547 | 11:09:52 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34265/tests/kraken/driver.html?testName=audio-oscillator) 11:09:53 INFO - PROCESS | 10547 | RSS: Main: 158167040 11:09:53 INFO - PROCESS | 10547 | 11:09:55 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:55 INFO - PROCESS | 10547 | RSS: Main: 157650944 11:09:55 INFO - PROCESS | 10547 | 11:09:58 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34265/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:59 INFO - PROCESS | 10547 | RSS: Main: 157237248 11:09:59 INFO - PROCESS | 10547 | 11:10:03 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34265/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:03 INFO - PROCESS | 10547 | RSS: Main: 157364224 11:10:03 INFO - PROCESS | 10547 | 11:10:06 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34265/tests/kraken/driver.html?testName=json-parse-financial) 11:10:07 INFO - PROCESS | 10547 | RSS: Main: 157696000 11:10:07 INFO - PROCESS | 10547 | 11:10:08 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:09 INFO - PROCESS | 10547 | RSS: Main: 157683712 11:10:09 INFO - PROCESS | 10547 | 11:10:10 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:11 INFO - PROCESS | 10547 | RSS: Main: 157413376 11:10:11 INFO - PROCESS | 10547 | 11:10:13 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:14 INFO - PROCESS | 10547 | RSS: Main: 157679616 11:10:14 INFO - PROCESS | 10547 | 11:10:16 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:17 INFO - PROCESS | 10547 | RSS: Main: 157388800 11:10:17 INFO - PROCESS | 10547 | 11:10:20 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:10:20 INFO - PROCESS | 10547 | RSS: Main: 158089216 11:10:20 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | Cycle 1(1): loaded http://localhost:34265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34265/tests/kraken/driver.html?testName=ai-astar) 11:10:22 INFO - PROCESS | 10547 | RSS: Main: 158670848 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | __start_tp_report 11:10:22 INFO - PROCESS | 10547 | _x_x_mozilla_page_load 11:10:22 INFO - PROCESS | 10547 | _x_x_mozilla_page_load_details 11:10:22 INFO - PROCESS | 10547 | |i|pagename|runs| 11:10:22 INFO - PROCESS | 10547 | |0;ai-astar;113;105;110;111;111;111;109;111;110;109 11:10:22 INFO - PROCESS | 10547 | |1;audio-beat-detection;153;124;152;172;132;159;149;130;187;128 11:10:22 INFO - PROCESS | 10547 | |2;audio-dft;163;160;162;159;161;162;160;162;161;162 11:10:22 INFO - PROCESS | 10547 | |3;audio-fft;75;76;76;163;75;76;75;76;170;77 11:10:22 INFO - PROCESS | 10547 | |4;audio-oscillator;83;84;144;86;84;84;140;87;83;153 11:10:22 INFO - PROCESS | 10547 | |5;imaging-gaussian-blur;118;117;118;117;118;118;118;118;118;118 11:10:22 INFO - PROCESS | 10547 | |6;imaging-darkroom;147;149;147;147;146;148;146;148;147;150 11:10:22 INFO - PROCESS | 10547 | |7;imaging-desaturate;95;95;95;97;95;96;95;96;95;96 11:10:22 INFO - PROCESS | 10547 | |8;json-parse-financial;54;53;52;53;57;54;53;52;59;52 11:10:22 INFO - PROCESS | 10547 | |9;json-stringify-tinderbox;59;60;59;60;59;60;59;59;60;60 11:10:22 INFO - PROCESS | 10547 | |10;stanford-crypto-aes;82;77;78;81;78;78;79;77;108;80 11:10:22 INFO - PROCESS | 10547 | |11;stanford-crypto-ccm;118;120;123;129;118;120;117;129;123;120 11:10:22 INFO - PROCESS | 10547 | |12;stanford-crypto-pbkdf2;155;151;156;153;162;156;155;153;159;152 11:10:22 INFO - PROCESS | 10547 | |13;stanford-crypto-sha256-iterative;62;66;62;63;61;60;60;61;60;64 11:10:22 INFO - PROCESS | 10547 | __end_tp_report 11:10:22 INFO - PROCESS | 10547 | __start_cc_report 11:10:22 INFO - PROCESS | 10547 | _x_x_mozilla_cycle_collect,874 11:10:22 INFO - PROCESS | 10547 | __end_cc_report 11:10:22 INFO - PROCESS | 10547 | __startTimestamp1470334222511__endTimestamp 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | ------- Summary: start ------- 11:10:22 INFO - PROCESS | 10547 | Number of tests: 14 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.11 (1.9%) stddev-sans-first:1.94 11:10:22 INFO - PROCESS | 10547 | Values: 113.0 105.0 110.0 111.0 111.0 111.0 109.0 111.0 110.0 109.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:152.50 stddev:20.58 (13.5%) stddev-sans-first:21.77 11:10:22 INFO - PROCESS | 10547 | Values: 153.0 124.0 152.0 172.0 132.0 159.0 149.0 130.0 187.0 128.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.12 11:10:22 INFO - PROCESS | 10547 | Values: 163.0 160.0 162.0 159.0 161.0 162.0 160.0 162.0 161.0 162.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.30 (50.4%) stddev-sans-first:40.01 11:10:22 INFO - PROCESS | 10547 | Values: 75.0 76.0 76.0 163.0 75.0 76.0 75.0 76.0 170.0 77.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:84.00 stddev:29.77 (35.4%) stddev-sans-first:30.70 11:10:22 INFO - PROCESS | 10547 | Values: 83.0 84.0 144.0 86.0 84.0 84.0 140.0 87.0 83.0 153.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:10:22 INFO - PROCESS | 10547 | Values: 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.27 (0.9%) stddev-sans-first:1.33 11:10:22 INFO - PROCESS | 10547 | Values: 147.0 149.0 147.0 147.0 146.0 148.0 146.0 148.0 147.0 150.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 11:10:22 INFO - PROCESS | 10547 | Values: 95.0 95.0 95.0 97.0 95.0 96.0 95.0 96.0 95.0 96.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:2.33 (4.4%) stddev-sans-first:2.47 11:10:22 INFO - PROCESS | 10547 | Values: 54.0 53.0 52.0 53.0 57.0 54.0 53.0 52.0 59.0 52.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:10:22 INFO - PROCESS | 10547 | Values: 59.0 60.0 59.0 60.0 59.0 60.0 59.0 59.0 60.0 60.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:78.50 stddev:9.35 (11.9%) stddev-sans-first:9.92 11:10:22 INFO - PROCESS | 10547 | Values: 82.0 77.0 78.0 81.0 78.0 78.0 79.0 77.0 108.0 80.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.50 stddev:4.32 (3.6%) stddev-sans-first:4.37 11:10:22 INFO - PROCESS | 10547 | Values: 118.0 120.0 123.0 129.0 118.0 120.0 117.0 129.0 123.0 120.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.50 stddev:3.33 (2.1%) stddev-sans-first:3.53 11:10:22 INFO - PROCESS | 10547 | Values: 155.0 151.0 156.0 153.0 162.0 156.0 155.0 153.0 159.0 152.0 11:10:22 INFO - PROCESS | 10547 | 11:10:22 INFO - PROCESS | 10547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.97 (3.2%) stddev-sans-first:2.09 11:10:22 INFO - PROCESS | 10547 | Values: 62.0 66.0 62.0 63.0 61.0 60.0 60.0 61.0 60.0 64.0 11:10:22 INFO - PROCESS | 10547 | -------- Summary: end -------- 11:10:22 INFO - PROCESS | 10547 | 11:10:23 INFO - TEST-INFO | 10547: exit 0 11:10:23 INFO - TEST-OK | kraken | took 60402ms 11:10:23 INFO - SUITE-END | took 1170s 11:10:23 INFO - Completed test suite (00:19:30) 11:10:23 INFO - javascript benchmark 11:10:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7583.337902232059, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3406.9829650851743, 3418.5384973028636, 3424.5376874121994, 3443.4146195146836, 3450.413429716948, 5640.520555752761, 5687.345955215152, 5703.03048481758, 5719.542436605072, 5738.483536481715, 5680.744366503507, 5684.204211410395, 5747.683877386742, 5748.080307150857, 5754.309482862052, 5133.127368347381, 5183.766730497118, 5227.581793456515, 5260.158374660055, 5272.393674727398, 5107.565856902149, 5167.173252279636, 5268.525832675058, 5272.0, 5272.314599102111, 5185.637005409604, 5221.973890130544, 5222.0, 5242.842714718565, 5256.316678831766, 5173.5861131109605, 5180.326557547513, 5230.163173892197, 5232.032074066272, 5246.737663116829, 5123.641345105844, 5144.922826157611, 5233.058049551118, 5238.895222095537, 5264.210368444764, 5437.564994800407, 5555.111182210827, 5591.496765291103, 5653.349864765563, 5694.060480020791, 6228.564000519966, 6247.468965137969, 6267.2479302484, 6267.561270711052, 6269.404406581368, 6031.879362412771, 6267.279262884781, 6301.621902685808, 6308.779192728279, 6313.463355614732, 5770.624909380919, 5779.450952159538, 5819.476247137778, 5877.5591830612875, 5881.323647780475, 6392.328805475451, 6421.743130274736, 6425.1968503937005, 6426.485881129498, 6450.354964503512, 5859.824205273849, 6010.519158467312, 6133.938660613337, 6146.078088286793, 6183.536234782319, 6094.45149936499, 6198.659073750897, 6212.47193988516, 6224.62652240867, 6233.407826256498, 6191.133241346125, 6199.194104766351, 6202.317745048041, 6213.161223234896, 6225.470834979077, 5912.674802885796, 6076.939230607726, 6079.604825686316, 6205.937940620536, 6208.658523781235, 4685.6017238535105, 4704.623630109583, 4707.7881495332795, 4712.363830882856, 4740.691855029412, 4204.222218889515, 4207.431996680471, 4227.429297044921, 4249.532551419341, 4253.787310634456, 5857.47282744555, 5970.940290597126, 5974.4324289192455, 5999.250093738283, 6019.969900150471, 6005.099235114768, 6021.187139736079, 6078.60489068218, 6132.448079672851, 6141.6007959482495, 5876.676782776988, 5895.263092113486, 5932.317783454958, 5942.049272116441, 5972.193753843262, 5297.073012222922, 5369.812056578079, 5370.2213179089595, 5371.3822910365025, 5378.596605254622, 6190.040543715641, 6389.808305750835, 6392.904106438407, 6429.260635026938, 6543.738250469928, 6271.31015588294, 6284.591501552384, 6300.243970723543, 6301.243850737849, 6319.778807741891, 6323.620582765049, 6482.675866206765, 6553.2136143663065, 6564.671766411565, 6571.901421478778, 6090.725917333819, 6111.7249723763425, 6140.785072522441, 6142.055645205473, 6186.938130618636, 6248.968755156195, 6252.187215662117, 6280.780172693934, 6287.748490060347, 6303.590266632654, 5887.970560147171, 6023.036314189709, 6046.395360464095, 6064.4541991221, 6064.969675151596, 6030.0, 6088.0, 6093.969530152321, 6099.542534309856, 6123.112148738497, 5988.6706231157705, 6046.7278972445465, 6058.697065146637, 6065.2418447694035, 6068.423499767515, 5943.613665111927, 5944.286685597756, 5967.254093238345, 6102.237220347457, 6130.570860039755, 5918.911216331672, 5919.348871624032, 5937.050071988461, 5938.138969849434, 5982.970085149546], "value": 5706.563448263998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4330998931038, 642.8360768004159, 651.7490766055071, 664.8204984654145, 681.1043477826661, 41567.0, 45961.31058034132, 46380.07239855205, 46464.76767616157, 46512.767436162816, 45724.314135288, 46297.537024629746, 46310.305345419845, 46521.0, 46616.53383466164, 8886.82226355474, 9018.323625728064, 9074.682386116487, 9082.77293067672, 9100.044495327995, 9019.819603607924, 9062.954685226598, 9080.455172689659, 9084.454932704026, 9106.63573457061, 9120.31597630177, 9141.268698504104, 9153.176214140725, 9159.084091590854, 9186.081391860827, 9027.503487308195, 9066.184043436122, 9068.546572671374, 9072.954635226848, 9096.181343679034, 9025.097490250988, 9052.547372631341, 9053.728388148365, 9071.773205669844, 9085.545722713838, 43174.78412607917, 43467.34798978018, 43483.0, 43538.0, 43743.56256437459, 3712.1647629283466, 3806.219724956405, 3808.828602712857, 3934.449177115206, 4229.386738922839, 34024.14939626529, 34449.0, 34541.654583454096, 34828.30343393118, 34971.0, 4662.930056049128, 4683.836065737717, 4699.154152252593, 4776.379070720819, 4781.0676918001, 361572.0, 361691.0, 362003.0, 364328.0, 365755.0, 38409.615903840604, 65525.0, 65592.67203664046, 65907.0, 66084.33915660878, 39099.41350879739, 40240.59759402427, 40640.0, 40723.0, 40801.591984080376, 14593.927030364992, 14824.03643763152, 14852.0, 14873.776893346609, 14898.702025959421, 11574.6527604172, 11865.525378984916, 11884.702882428008, 11891.821622675667, 11921.582744604071, 9233.907660923305, 9235.168834804765, 9257.398269112486, 9294.535273236312, 9298.86051709225, 3543.557055368079, 3558.1104723819044, 3596.1009747563107, 3600.3879340512176, 3605.8725352041897, 1016.5832008876473, 1100.4002818463957, 1132.8583927009124, 1145.2441388683428, 1154.9826752598717, 30779.23051923675, 34177.316453670785, 37120.01436401796, 37242.8137859309, 37776.055598610255, 1149.2587281203744, 1159.9362035088152, 1236.4003458322707, 1238.139493052338, 1247.3451437995125, 17243.0, 17331.30674772995, 17573.0, 17618.735718964224, 17676.02781847011, 572946.0, 577741.0, 577939.0, 578125.0, 578254.0, 62338.68830655908, 63072.68463657652, 63281.36718632847, 63487.36512634907, 63765.04352434717, 1502.721996430664, 1524.809398825147, 1527.618095476131, 1537.3927298717167, 1537.9000364976241, 32143.678563214067, 32864.835675822425, 33176.1705957353, 33225.833870830495, 33637.99086027423, 56985.715071424376, 57665.0, 57683.1347529779, 57811.0, 57964.13053804281, 526565.0, 526629.0, 528140.0, 528162.0, 529194.0, 30779.692203077684, 30871.84564077165, 31242.21894452657, 31910.36179276355, 32154.83922580372, 52487.0, 53593.19610205928, 53640.73179634077, 54033.18950215828, 55120.72439637776, 45420.0, 45565.31652025288, 45695.086098277185, 46759.29861052019, 47430.76284618555, 44572.0, 44671.10657786891, 45568.316475252235, 45575.0, 46958.76520617375, 43451.0, 44163.0, 44628.10743785171, 45443.0, 48373.75813120912, 39914.0, 40108.197836042535, 40112.1977560453, 40117.39823902585, 40971.59028409797, 30217.64535493434, 30427.695723043373, 30574.694253057183, 30652.693473064985, 30786.230344241572], "value": 20254.503862914527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.7764584770073, 422.15358206795406, 431.6503632058032, 433.25696430621485, 443.3195045604995, 18672.62654746906, 19812.60374792505, 20417.28539501118, 20890.164393424282, 20904.26835060773, 18155.0, 18400.723989140173, 18562.257509699597, 18630.53423664409, 18766.43700688978, 5600.635958662694, 5759.712014399284, 5814.273215848019, 5817.214676018747, 5818.0, 5505.834824955237, 5754.223179870705, 5856.824295271127, 5870.559708021916, 5918.970405147989, 5907.409259074079, 5915.349311575723, 5931.614445061079, 6528.41244288014, 6692.83267918301, 6613.008048792672, 6667.599944003376, 6684.298148694365, 6706.9329306706795, 6722.025306330579, 5758.827235182951, 5892.882142357172, 5894.381089985575, 5897.557683173779, 5908.084246941731, 13561.321933903266, 13972.790408143886, 19532.511687207792, 23512.64731029036, 23712.170074047324, 2328.569214695287, 2332.2420213430532, 2347.2254156128606, 2393.904243830245, 2614.9215523534326, 10476.68569942903, 10922.29005114665, 11003.779924401468, 13025.153365031243, 14519.0, 1948.7953764854628, 2052.107333310015, 2098.3495116513777, 2133.157402825875, 2134.647783115784, 82208.17791822125, 83026.0, 84194.57902710508, 86539.99999999937, 86552.0, 11308.0, 11573.826392604118, 11730.941345293219, 11754.11844111695, 11890.16768826174, 16730.330786768394, 16738.330466781437, 16839.831601684073, 16841.57896052584, 16907.408240711517, 7786.649600767979, 8291.0, 8292.58537073144, 8497.320214382835, 8777.078406767325, 7899.973003509507, 7900.091489478668, 7959.522428654183, 7993.9200607994335, 7994.880076798852, 4177.4569305990635, 4503.144402563568, 5087.465816089331, 5192.4547922468355, 5200.193969934666, 2040.7449068866392, 2068.8965551722654, 2097.0144032304793, 2143.7641859395453, 2144.142343062756, 972.9075737804898, 1004.1916257412706, 1018.2159737002466, 1087.6138970665459, 1100.565276715709, 18781.624367512573, 19607.90196049039, 19657.41027769169, 19805.504862378555, 19854.1065652046, 1049.0925349572565, 1058.3015209961388, 1083.7615724540588, 1097.1332647208617, 1103.3545375954996, 10714.303570267908, 11085.722856928642, 11151.0, 11151.219414640897, 11154.832677509843, 477716.0, 487690.0, 507282.0, 508752.0, 509813.0, 94873.5256323714, 95980.52009740047, 97153.0, 98491.0, 98782.0, 503.509078648315, 514.9897002059938, 515.4845154845154, 516.2565905096724, 517.1441264706916, 10897.346159230154, 11415.258008229439, 11571.826422603499, 11733.647990560297, 11741.11941604366, 40513.39229911612, 42548.0, 44013.0, 44081.0, 44352.0, 58312.70843645755, 59830.40169598248, 59897.0, 60667.69666151641, 60827.0, 8695.391322607356, 8896.243819275434, 8897.555122243992, 9253.0, 9361.906380936103, 10018.448985305879, 12951.935240323737, 13448.46206151743, 13473.056886017885, 14013.159210446998, 12204.755904881675, 12336.444859981502, 12349.691257718629, 12390.62828115158, 12531.060170487068, 11115.577191232576, 12366.970092327438, 12384.56654017105, 12392.442340094538, 12713.682157946125, 12373.690657733268, 12393.442295096922, 12421.31682757457, 12516.93741531323, 12630.115891887479, 9064.456132632064, 9076.410033348075, 9131.406458580172, 9183.678571249975, 9491.715248542554, 9130.863037054316, 11761.47073381717, 12118.333491658044, 12128.696782580153, 12191.878081219429], "value": 9273.98155224041, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.4005877766451, 1607.3570571771293, 1837.4212123181196, 1948.3278268997192, 1962.3720409468967, 8114.594270286477, 9017.819643607125, 9052.140046695562, 9537.713868583945, 9622.56698448569, 9144.177024067849, 9408.81182376352, 9430.622775088988, 9442.150206481416, 9449.480278584675, 2456.877156142199, 2489.9542192279196, 2505.7744802967727, 2505.9749402506013, 2513.3088400689867, 2380.9642855357183, 2478.876056197192, 2497.425592113815, 2501.7123030851412, 2503.086373473687, 2436.317831007321, 2437.317551085699, 2471.641611966264, 2475.6905386826647, 2480.293116461809, 2421.903123875043, 2443.816713746476, 2451.0563433078214, 2465.8890349934295, 2475.232677869866, 2385.594448943684, 2406.3984003999, 2406.554787364343, 2421.5883299838893, 2421.782039616443, 9432.622695092188, 9469.195118414944, 9491.477968711788, 9502.809943801154, 9517.23862091038, 5370.865728356784, 5568.387477377485, 5578.9163162552595, 5583.441655834384, 5600.803971861006, 3399.9490007649906, 3464.9826750866337, 3531.1172206948263, 3536.752427330088, 3570.928581428383, 1118.530217308724, 1128.5147386623748, 1158.6176561734692, 1168.4858662188694, 1199.1366216324232, 13294.933525332312, 13340.399682014333, 13344.065915385927, 13348.466061357534, 13372.398242079129, 4794.736289504111, 4817.927731084036, 4819.180739274332, 4851.175300198904, 4915.18899381598, 11039.448027598588, 11175.83236251457, 11204.49579768896, 11208.831867521994, 11223.55105795759, 5503.229547863302, 5514.448555144453, 5552.555795536347, 5559.971405290034, 5565.888682226414, 4463.486699029589, 4954.77703503336, 5071.41678706946, 5112.054269960069, 5113.795448182031, 4315.438992930899, 4331.675124365685, 4367.323064924942, 4372.103718737651, 4395.7142785718825, 1281.2120545864414, 1341.121565374681, 1343.9798403023963, 1358.3547814788094, 1379.5723325769043, 988.3180605382263, 1026.4046852825343, 1122.2480937771713, 1143.519721716881, 1145.0438883532345, 6622.9006564901565, 6739.359760822714, 6802.897956530656, 6859.039734437183, 6864.7940561783225, 493.5286801104936, 510.36969342861534, 512.4209643103344, 513.7765072193607, 518.4815184815185, 4523.072770082125, 4580.473245576802, 4602.861914142581, 4643.907121857544, 4665.090307390026, 11147.665570032912, 11597.18819682614, 11955.820662689892, 11958.282503049844, 11983.34091624969, 11728.179027468166, 11767.88232117685, 11776.11679124069, 11819.940900295616, 11849.111316651286, 8468.195521425454, 8585.184407481403, 8601.698940537051, 8631.266342360845, 8641.956790216009, 6225.968870155621, 6288.506268085689, 6415.743370265137, 6457.773977910751, 6529.608223506605, 9722.833260008843, 9890.357126786736, 9902.108810207115, 9924.15644670211, 10036.397816131055, 10047.899521004696, 10111.54498047575, 10186.694399168036, 10201.642942497274, 10215.897841021495, 7682.884756728542, 7761.0, 7914.0, 8387.287080598218, 8424.283935865275, 9244.630214791601, 9268.258539316974, 9273.76815579589, 9351.158395744416, 9366.81266374655, 8088.87866682012, 8319.916800831914, 8391.832163356821, 8548.572571371531, 8553.401261911606, 7702.345300649507, 7823.491473054233, 7976.561289129154, 7992.200779922194, 8179.141190174946, 7632.236776322324, 7654.8086297843, 7736.1877002916135, 7813.921860781319, 7822.804429889298, 5600.57995650336, 5707.1153971134545, 5719.628224165416, 5749.8787736391005, 5855.765769369177, 5259.21111833228, 5269.920951185812, 5287.603429742708, 5313.814016509404, 5351.224072509543], "value": 4857.0016824316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.83535855701587, 340.87387666563376, 341.2288228603356, 344.748333716387, 352.56106147845935, 5679.744411501482, 5722.855428914213, 5770.538356931446, 5778.27771528559, 5822.592418530699, 5634.4365563443735, 5637.267155269809, 5649.943500565003, 5659.66042037478, 5661.66030038198, 4393.846215382462, 4430.556944305576, 4432.822687092513, 4434.467863856342, 4436.223660859337, 4232.446771517429, 4408.669349798762, 4437.733735975836, 4443.37792709021, 4448.310511870665, 4399.604035636792, 4408.14041261954, 4412.338149277618, 4415.580519850609, 4425.424694789689, 4402.7578483183415, 4414.271645178542, 4424.654932885575, 4436.136822534543, 4450.755208463534, 3745.9625403745886, 3918.5689574146822, 3929.155231625214, 3956.683465322796, 3957.0, 5496.258005169291, 5512.724363781795, 5516.9448305516835, 5538.6122971392015, 5577.386487486373, 5142.254373115915, 5167.534921857014, 5175.327207463043, 5177.508136727005, 5180.119379705459, 5860.765569377219, 6006.699665016732, 6028.216331876872, 6044.758209671608, 6045.788397406113, 4409.11817636474, 4411.691181617288, 4412.316091005867, 4417.447819022622, 4432.667549933735, 6142.6007309525185, 6302.243730752339, 6320.0, 6365.0904728581245, 6370.203724534434, 4466.977665111719, 4474.731516109044, 4477.910441791211, 4500.774961251925, 4517.5482451755215, 4540.182767101887, 4542.454905411306, 4559.589636932692, 4576.153411618861, 4608.400907881954, 5146.639735218499, 5154.098032844237, 5172.560332371715, 5190.584753219733, 5197.454267301954, 5801.824315881545, 5840.8247752567495, 5995.130706047686, 6066.211392519032, 6135.570510064342, 1558.3610719604908, 1574.2600977540537, 1575.9763603545955, 1576.172509432534, 1583.22422013215, 1011.8279892418159, 1011.8785745710414, 1012.2762225009154, 1018.4195008844887, 1045.3153184664056, 5222.738863056832, 5268.315119034578, 5294.7617357219015, 5295.232191332312, 5305.920411193835, 5506.64206826555, 5508.366537848118, 5509.044289277329, 5512.5314348280845, 5538.833834984957, 4909.0, 5226.491284183613, 5271.604629652791, 5299.549538289289, 5318.468153184728, 2926.5610158475974, 2932.560115982577, 2938.9713600239743, 2950.704929507075, 2964.273752930546, 5695.380125142398, 5725.456081672234, 5736.680563470425, 5760.42395760429, 5770.855728606734, 6042.425969532887, 6423.935760642427, 6445.838854028593, 6463.547551671432, 6478.060681201199, 6539.836504087436, 6552.541322107407, 6553.279139294674, 6571.67141642916, 6615.801525954229, 6007.897235967376, 6179.814605561661, 6196.845078872884, 6237.719302631302, 6285.49716022708, 6095.0, 6140.1710769047395, 6193.473554747897, 6195.535334849814, 6198.0785956353675, 6281.434670879643, 6438.679595503497, 6477.805665830033, 6496.642684652389, 6542.54202205841, 4296.656267498655, 4304.332828411601, 4331.566843315769, 4343.739375637472, 4349.412829268135, 6065.636061836304, 6262.561620686508, 6292.496600271876, 6322.841928951813, 6332.841678957879, 6055.576109672281, 6059.969700151471, 6091.7563297467605, 6105.48103411215, 6113.969430152821, 6082.665453400105, 6085.208922840179, 6101.694915254131, 6109.31190276277, 6116.847078823065, 5768.971155144198, 6008.459238668541, 6021.969890150521, 6027.126066720213, 6027.517798576016, 6123.755049797958, 6124.448799608057, 6142.170806941006, 6148.0, 6150.292716337678, 5781.0, 5982.730777115127, 5990.131430942576, 6031.457168854824, 6052.727627256696], "value": 4542.837135685442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.7634797734671, 823.7775800533856, 854.5641722721413, 874.4447275979755, 912.2154946745802, 14779.630509237275, 14794.408223671067, 14880.330385132667, 15202.619934501643, 15645.687086258282, 14845.851541484582, 15108.47120350788, 15192.164430956293, 15373.615659608515, 15441.305141268642, 866.679328648401, 914.3599480363739, 919.7746552094746, 920.9815803683922, 922.1516205091299, 897.4839467306292, 897.7396554999042, 903.5708038681639, 904.3036861616584, 905.0316161706976, 938.1650331205233, 944.4427787605312, 947.2327414794005, 948.928830337724, 951.281782254397, 945.1493655709847, 946.129560804062, 946.4841661294611, 948.231932134966, 951.4481600671628, 692.4564217089611, 694.9583025018516, 695.1415002471944, 695.1935754524727, 697.0206859362604, 15245.0, 15272.618184545365, 15282.465113721077, 15320.923395383063, 15327.386904523806, 15714.528564143095, 15860.127692976881, 15912.443064492687, 15944.920275398548, 15994.920025399799, 12527.123101382907, 12557.74884502314, 12568.120231583793, 12859.549915752903, 12921.289329086896, 4160.729552579072, 4162.937555936664, 4179.310413781723, 4187.120704652027, 4226.049138943744, 79926.20073799304, 79960.0, 80092.19907800906, 80457.0, 81032.59483702603, 12037.759244815055, 12513.624591262094, 12600.4329805159, 12630.747385052431, 12643.241405515699, 24054.278371648878, 24091.0, 24095.156669516484, 24135.15526956548, 24247.515049698908, 9034.954825225963, 9064.410813297247, 9199.862002069975, 9286.860697089549, 9325.626974920928, 5161.148410512298, 5190.8183213587345, 5329.840104796862, 5337.973310133424, 5436.130219164994, 3963.7819919904105, 4134.255833949918, 4136.503619565671, 4139.110091330378, 4142.212979533879, 678.0710426715333, 690.3648643248224, 709.0994437064899, 711.8184862860041, 732.3847967707152, 642.6047980491963, 772.7449941519285, 780.8126049748133, 828.6685325869701, 834.7913021744564, 10797.83803242952, 10914.508847101899, 10925.945370273257, 10937.83593246102, 10982.670519884416, 661.8775526527608, 718.9653281214152, 744.5383862005591, 747.4506237915128, 757.6742000939539, 4855.247436647325, 5003.7998480061115, 5032.7735251913755, 5043.52086551777, 5072.82245121419, 76233.0, 76788.0, 121081.0, 122295.0, 124773.0, 75838.0, 88531.0, 108396.4580177094, 110784.0, 112615.4369228165, 75792.0, 98535.9884192351, 99569.50215248877, 100005.0, 101232.49383753035, 8537.615807288812, 9136.497492637704, 9826.4104153751, 9836.213102951604, 9900.554475048497, 54622.726886365315, 55200.0, 56960.145597816896, 57676.71161644165, 58925.41074589199, 78382.60808696148, 79906.60046699729, 80249.19750802651, 80528.59735701284, 81134.59432702798, 12836.0, 13193.406296716863, 13232.603021909357, 13380.0, 13915.234662093682, 14125.364358603681, 14824.725715814962, 14954.775678365051, 15215.0, 15299.0, 13653.726925461633, 13834.0, 13875.0, 13906.304684765924, 13990.0, 13555.661108472366, 13734.519291824738, 13742.381592828548, 14076.085054471427, 14169.29153542298, 12345.444454999726, 13054.804177937529, 13154.736905262032, 13355.0, 13450.0, 9853.655122070693, 10811.0, 10949.671509854717, 11376.488058037243, 11637.301761894314, 12106.939465302617, 12285.69285767863, 12799.488020479077, 12828.615141545768, 13073.607791766262], "value": 8040.161255881892, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 111.0, 111.0, 111.0, 109.0, 111.0, 110.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 152.0, 172.0, 132.0, 159.0, 149.0, 130.0, 187.0, 128.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 159.0, 161.0, 162.0, 160.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 163.0, 75.0, 76.0, 75.0, 76.0, 170.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 144.0, 86.0, 84.0, 84.0, 140.0, 87.0, 83.0, 153.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 146.0, 148.0, 146.0, 148.0, 147.0, 150.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 57.0, 54.0, 53.0, 52.0, 59.0, 52.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 78.0, 81.0, 78.0, 78.0, 79.0, 77.0, 108.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 123.0, 129.0, 118.0, 120.0, 117.0, 129.0, 123.0, 120.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 156.0, 153.0, 162.0, 156.0, 155.0, 153.0, 159.0, 152.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 62.0, 63.0, 61.0, 60.0, 60.0, 61.0, 60.0, 64.0], "value": 61.9, "unit": "score"}]}]} 11:10:23 INFO - Return code: 0 11:10:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:10:23 ERROR - # TBPL SUCCESS # 11:10:23 INFO - Running post-action listener: _resource_record_post_action 11:10:23 INFO - ##### 11:10:23 INFO - ##### Finished run-tests step (success) 11:10:23 INFO - ##### 11:10:23 INFO - Running post-run listener: _resource_record_post_run 11:10:23 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 28672; Write bytes: 219488256; Read time: 32; Write time: 161052 11:10:23 INFO - TinderboxPrint: CPU usage
13.3% 11:10:23 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 32 11:10:23 INFO - TinderboxPrint: I/O write bytes / time
219,488,256 / 161,052 11:10:23 INFO - TinderboxPrint: CPU idle
8,196.1 (86.7%) 11:10:23 INFO - TinderboxPrint: CPU user
1,208.2 (12.8%) 11:10:23 INFO - TinderboxPrint: Swap in / out
0 / 0 11:10:23 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 573440; Read time: 0; Write time: 52 11:10:23 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218914816; Read time: 20; Write time: 161000 11:10:24 INFO - Running post-run listener: _upload_blobber_files 11:10:24 INFO - Blob upload gear active. 11:10:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:10:24 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 11:10:24 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'] 11:10:24 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 11:10:24 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:10:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:10:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:25 INFO - (blobuploader) - INFO - Done attempting. 11:10:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:10:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:10:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:26 INFO - (blobuploader) - INFO - Done attempting. 11:10:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:10:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:10:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:30 INFO - (blobuploader) - INFO - Done attempting. 11:10:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:10:30 INFO - Return code: 0 11:10:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:10:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:10:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32afe6978af87488563a03abc9293506c7ff72ef6d7f947728d51856769e00faf88e49cfedffe47e4535d96387e2bebe35dab4720b69ce540fdb440cf5d5aaf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d7f86c5f6df323a54ea00e50397a5f9f451ca8c7f1b6faa31c9a1cf56d75f14df6add1f23418704e7501822bbddf12ab50f96bc62f6c30ac00cc0e518aa717a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6126cdc69376a1276b79e65c0c9fe00810c8dcbf638eb7833de9ead8d08472cd886c6e1e1766eb0432f6f372e138a4263319411fe6cbe2faf8cf4b55454d4b0"} 11:10:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:10:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:10:30 INFO - Contents: 11:10:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32afe6978af87488563a03abc9293506c7ff72ef6d7f947728d51856769e00faf88e49cfedffe47e4535d96387e2bebe35dab4720b69ce540fdb440cf5d5aaf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d7f86c5f6df323a54ea00e50397a5f9f451ca8c7f1b6faa31c9a1cf56d75f14df6add1f23418704e7501822bbddf12ab50f96bc62f6c30ac00cc0e518aa717a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6126cdc69376a1276b79e65c0c9fe00810c8dcbf638eb7833de9ead8d08472cd886c6e1e1766eb0432f6f372e138a4263319411fe6cbe2faf8cf4b55454d4b0"} 11:10:30 INFO - Running post-run listener: copy_logs_to_upload_dir 11:10:30 INFO - Copying logs to upload dir... 11:10:30 INFO - mkdir: /builds/slave/test/build/upload/logs 11:10:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.011244 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-04 11:10:30.024303) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:30.028029) ========= 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=0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32afe6978af87488563a03abc9293506c7ff72ef6d7f947728d51856769e00faf88e49cfedffe47e4535d96387e2bebe35dab4720b69ce540fdb440cf5d5aaf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d7f86c5f6df323a54ea00e50397a5f9f451ca8c7f1b6faa31c9a1cf56d75f14df6add1f23418704e7501822bbddf12ab50f96bc62f6c30ac00cc0e518aa717a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6126cdc69376a1276b79e65c0c9fe00810c8dcbf638eb7833de9ead8d08472cd886c6e1e1766eb0432f6f372e138a4263319411fe6cbe2faf8cf4b55454d4b0"} build_url:https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/Wu_kQKnNQIW4_pjer6nZzA/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/32afe6978af87488563a03abc9293506c7ff72ef6d7f947728d51856769e00faf88e49cfedffe47e4535d96387e2bebe35dab4720b69ce540fdb440cf5d5aaf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d7f86c5f6df323a54ea00e50397a5f9f451ca8c7f1b6faa31c9a1cf56d75f14df6add1f23418704e7501822bbddf12ab50f96bc62f6c30ac00cc0e518aa717a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6126cdc69376a1276b79e65c0c9fe00810c8dcbf638eb7833de9ead8d08472cd886c6e1e1766eb0432f6f372e138a4263319411fe6cbe2faf8cf4b55454d4b0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:30.053900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:30.054274) ========= 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=0333a256a5e4f052382dd180000001b1-1470332548.722880-1540848989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:10:30.137971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:10:30.138322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:10:30.138772) ========= ========= Total master_lag: 0.36 =========