builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1467947379.81 results: success (0) buildid: 20160707173525 builduid: abe08bfe27d5417eacbf281e784585e3 revision: 0f0647de29598b4d556e32372612329a9d743a12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:39.809965) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:39.810680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:39.811091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:39.826806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:39.827145) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 20:09:40-- 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% 65.9M=0s 2016-07-07 20:09:40 (65.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118649 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:39.961192) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:39.961579) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018213 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:40.011618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:40.011978) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f0647de29598b4d556e32372612329a9d743a12 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f0647de29598b4d556e32372612329a9d743a12 --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=a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 20:09:40,337 truncating revision to first 12 chars 2016-07-07 20:09:40,338 Setting DEBUG logging. 2016-07-07 20:09:40,338 attempt 1/10 2016-07-07 20:09:40,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f0647de2959?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 20:09:40,688 unpacking tar archive at: mozilla-aurora-0f0647de2959/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:40.715802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:40.716155) ========= script_repo_revision: 0f0647de29598b4d556e32372612329a9d743a12 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:40.716593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:40.716869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:09:40.726185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-07 20:09:40.726487) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:09:41 INFO - MultiFileLogger online at 20160707 20:09:41 in /builds/slave/test 20:09:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:09:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:41 INFO - {'append_to_log': False, 20:09:41 INFO - 'base_work_dir': '/builds/slave/test', 20:09:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:09:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:41 INFO - 'branch': 'Mozilla-Aurora', 20:09:41 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:41 INFO - 'config_files': ('talos/linux_config.py',), 20:09:41 INFO - 'default_actions': ('clobber', 20:09:41 INFO - 'read-buildbot-config', 20:09:41 INFO - 'download-and-extract', 20:09:41 INFO - 'populate-webroot', 20:09:41 INFO - 'create-virtualenv', 20:09:41 INFO - 'install', 20:09:41 INFO - 'run-tests'), 20:09:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:41 INFO - 'download_minidump_stackwalk': True, 20:09:41 INFO - 'download_symbols': 'ondemand', 20:09:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:41 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:41 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:41 INFO - 'installer_path': 'installer.exe', 20:09:41 INFO - 'log_level': 'info', 20:09:41 INFO - 'log_name': 'talos', 20:09:41 INFO - 'log_to_console': True, 20:09:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:09:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:09:41 INFO - 'opt_config_files': (), 20:09:41 INFO - 'pip_index': False, 20:09:41 INFO - 'sps_profile': False, 20:09:41 INFO - 'sps_profile_interval': 0, 20:09:41 INFO - 'suite': 'dromaeojs-e10s', 20:09:41 INFO - 'system_bits': '32', 20:09:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:41 INFO - 'title': 'talos-linux64-ix-062', 20:09:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:41 INFO - 'use_talos_json': True, 20:09:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:41 INFO - 'work_dir': 'build'} 20:09:41 INFO - ##### 20:09:41 INFO - ##### Running clobber step. 20:09:41 INFO - ##### 20:09:41 INFO - Running pre-action listener: _resource_record_pre_action 20:09:41 INFO - Running main action method: clobber 20:09:41 INFO - rmtree: /builds/slave/test/build 20:09:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:42 INFO - Running post-action listener: _resource_record_post_action 20:09:42 INFO - ##### 20:09:42 INFO - ##### Finished clobber step (success) 20:09:42 INFO - ##### 20:09:42 INFO - ##### 20:09:42 INFO - ##### Running read-buildbot-config step. 20:09:42 INFO - ##### 20:09:42 INFO - Running pre-action listener: _resource_record_pre_action 20:09:42 INFO - Running main action method: read_buildbot_config 20:09:42 INFO - Using buildbot properties: 20:09:42 INFO - { 20:09:42 INFO - "project": "", 20:09:42 INFO - "product": "firefox", 20:09:42 INFO - "script_repo_revision": "production", 20:09:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:09:42 INFO - "repository": "", 20:09:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:09:42 INFO - "buildid": "20160707173525", 20:09:42 INFO - "pgo_build": "True", 20:09:42 INFO - "basedir": "/builds/slave/test", 20:09:42 INFO - "buildnumber": 434, 20:09:42 INFO - "slavename": "talos-linux64-ix-062", 20:09:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:09:42 INFO - "platform": "ubuntu64_hw", 20:09:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:09:42 INFO - "branch": "mozilla-aurora", 20:09:42 INFO - "repo_path": "releases/mozilla-aurora", 20:09:42 INFO - "revision": "0f0647de29598b4d556e32372612329a9d743a12", 20:09:42 INFO - "stage_platform": "linux64-pgo", 20:09:42 INFO - "builduid": "abe08bfe27d5417eacbf281e784585e3", 20:09:42 INFO - "slavebuilddir": "test" 20:09:42 INFO - } 20:09:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 20:09:42 INFO - Running post-action listener: _resource_record_post_action 20:09:42 INFO - ##### 20:09:42 INFO - ##### Finished read-buildbot-config step (success) 20:09:42 INFO - ##### 20:09:42 INFO - ##### 20:09:42 INFO - ##### Running download-and-extract step. 20:09:42 INFO - ##### 20:09:42 INFO - Running pre-action listener: _resource_record_pre_action 20:09:42 INFO - Running main action method: download_and_extract 20:09:42 INFO - mkdir: /builds/slave/test/build/tests 20:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:42 INFO - https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 20:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 20:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 20:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:09:42 INFO - Downloaded 1361 bytes. 20:09:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 20:09:42 INFO - Using the following test package requirements: 20:09:42 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 20:09:42 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:09:42 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:09:42 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'jsshell-linux-x86_64.zip'], 20:09:42 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:09:42 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 20:09:42 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:09:42 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:09:42 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:09:42 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 20:09:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:09:42 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:42 INFO - https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 20:09:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 20:09:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 20:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:09:44 INFO - Downloaded 24525643 bytes. 20:09:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:09:45 INFO - Return code: 0 20:09:45 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:45 INFO - https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:09:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 20:09:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 20:09:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 20:09:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:09:46 INFO - Downloaded 24525643 bytes. 20:09:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:09:47 INFO - Return code: 0 20:09:47 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')]} 20:09:47 INFO - https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:09:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 20:09:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 20:09:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 20:09:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:09:48 INFO - Downloaded 10833369 bytes. 20:09:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:09:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:09:49 INFO - Return code: 0 20:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:49 INFO - https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:09:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 20:09:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 20:09:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 20:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:09:50 INFO - Downloaded 63639725 bytes. 20:09:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 20:09:50 INFO - mkdir: /builds/slave/test/properties 20:09:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:50 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:50 INFO - Contents: 20:09:50 INFO - build_url:https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 20:09:51 INFO - Running post-action listener: _resource_record_post_action 20:09:51 INFO - Running post-action listener: set_extra_try_arguments 20:09:51 INFO - ##### 20:09:51 INFO - ##### Finished download-and-extract step (success) 20:09:51 INFO - ##### 20:09:51 INFO - ##### 20:09:51 INFO - ##### Running populate-webroot step. 20:09:51 INFO - ##### 20:09:51 INFO - Running pre-action listener: _resource_record_pre_action 20:09:51 INFO - Running main action method: populate_webroot 20:09:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:51 INFO - '--tppagecycles', 20:09:51 INFO - '7'], 20:09:51 INFO - 'tests': ['tsvgm']}}, 20:09:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['damp', 'tps']}, 20:09:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'tests': ['damp', 'tps']}, 20:09:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['dromaeo_dom']}, 20:09:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['a11yr', 20:09:51 INFO - 'ts_paint', 20:09:51 INFO - 'tpaint', 20:09:51 INFO - 'sessionrestore', 20:09:51 INFO - 'sessionrestore_no_auto_restore', 20:09:51 INFO - 'tabpaint']}, 20:09:51 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:51 INFO - 'ts_paint', 20:09:51 INFO - 'tpaint', 20:09:51 INFO - 'sessionrestore', 20:09:51 INFO - 'sessionrestore_no_auto_restore', 20:09:51 INFO - 'tabpaint']}, 20:09:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:51 INFO - 'ts_paint', 20:09:51 INFO - 'tpaint', 20:09:51 INFO - 'sessionrestore', 20:09:51 INFO - 'sessionrestore_no_auto_restore', 20:09:51 INFO - 'tabpaint']}, 20:09:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:51 INFO - 'ts_paint', 20:09:51 INFO - 'tpaint', 20:09:51 INFO - 'sessionrestore', 20:09:51 INFO - 'sessionrestore_no_auto_restore', 20:09:51 INFO - 'tabpaint']}, 20:09:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['a11yr', 20:09:51 INFO - 'ts_paint', 20:09:51 INFO - 'tpaint', 20:09:51 INFO - 'sessionrestore', 20:09:51 INFO - 'sessionrestore_no_auto_restore', 20:09:51 INFO - 'tabpaint']}, 20:09:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['a11yr', 20:09:51 INFO - 'ts_paint', 20:09:51 INFO - 'tpaint', 20:09:51 INFO - 'sessionrestore', 20:09:51 INFO - 'sessionrestore_no_auto_restore', 20:09:51 INFO - 'tabpaint']}, 20:09:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['tsvgx', 20:09:51 INFO - 'tsvgr_opacity', 20:09:51 INFO - 'tart', 20:09:51 INFO - 'tscrollx', 20:09:51 INFO - 'cart']}, 20:09:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:51 INFO - 'tsvgr_opacity', 20:09:51 INFO - 'tart', 20:09:51 INFO - 'tscrollx', 20:09:51 INFO - 'cart']}, 20:09:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'talos_options': ['--disable-e10s'], 20:09:51 INFO - 'tests': ['tp5o']}, 20:09:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'tests': ['tp5o']}, 20:09:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'talos_options': ['--disable-e10s', 20:09:51 INFO - '--xperf_path', 20:09:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:51 INFO - 'tests': ['tp5n']}, 20:09:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:09:51 INFO - 'talos_options': ['--xperf_path', 20:09:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:51 INFO - 'tests': ['tp5n']}}, 20:09:51 INFO - 'talos.zip': {'path': '', 20:09:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:51 INFO - Running post-action listener: _resource_record_post_action 20:09:51 INFO - ##### 20:09:51 INFO - ##### Finished populate-webroot step (success) 20:09:51 INFO - ##### 20:09:51 INFO - ##### 20:09:51 INFO - ##### Running create-virtualenv step. 20:09:51 INFO - ##### 20:09:51 INFO - Running pre-action listener: _resource_record_pre_action 20:09:51 INFO - Running main action method: create_virtualenv 20:09:51 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:51 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 20:09:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:51 INFO - Using real prefix '/usr' 20:09:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:53 INFO - Installing pip.................done. 20:09:53 INFO - Return code: 0 20:09:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:53 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:09:53 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 20:09:53 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 20:09:53 INFO - Using env: {'DISPLAY': ':0', 20:09:53 INFO - 'HOME': '/home/cltbld', 20:09:53 INFO - 'LANG': 'en_US.UTF-8', 20:09:53 INFO - 'LANGUAGE': 'en_US:en', 20:09:53 INFO - 'LOGNAME': 'cltbld', 20:09:53 INFO - 'MAIL': '/var/mail/cltbld', 20:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:53 INFO - 'MOZ_NO_REMOTE': '1', 20:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:53 INFO - 'NO_EM_RESTART': '1', 20:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:53 INFO - 'PWD': '/builds/slave/test', 20:09:53 INFO - 'SHELL': '/bin/bash', 20:09:53 INFO - 'SHLVL': '1', 20:09:53 INFO - 'TERM': 'linux', 20:09:53 INFO - 'TMOUT': '86400', 20:09:53 INFO - 'USER': 'cltbld', 20:09:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:53 INFO - '_': '/tools/buildbot/bin/python'} 20:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:54 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 20:09:54 INFO - Cleaning up... 20:09:54 INFO - Return code: 0 20:09:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09:54 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')]} 20:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 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')]} 20:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:54 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:09:54 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 20:09:54 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 20:09:54 INFO - Using env: {'DISPLAY': ':0', 20:09:54 INFO - 'HOME': '/home/cltbld', 20:09:54 INFO - 'LANG': 'en_US.UTF-8', 20:09:54 INFO - 'LANGUAGE': 'en_US:en', 20:09:54 INFO - 'LOGNAME': 'cltbld', 20:09:54 INFO - 'MAIL': '/var/mail/cltbld', 20:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:54 INFO - 'MOZ_NO_REMOTE': '1', 20:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:54 INFO - 'NO_EM_RESTART': '1', 20:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:54 INFO - 'PWD': '/builds/slave/test', 20:09:54 INFO - 'SHELL': '/bin/bash', 20:09:54 INFO - 'SHLVL': '1', 20:09:54 INFO - 'TERM': 'linux', 20:09:54 INFO - 'TMOUT': '86400', 20:09:54 INFO - 'USER': 'cltbld', 20:09:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:54 INFO - '_': '/tools/buildbot/bin/python'} 20:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:54 INFO - Downloading/unpacking psutil>=3.1.1 20:09:54 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 20:09:54 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 20:09:54 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 20:09:54 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 20:09:54 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 20:09:54 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 20:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:56 INFO - Installing collected packages: psutil 20:09:56 INFO - Running setup.py install for psutil 20:09:56 INFO - building 'psutil._psutil_linux' extension 20:09:56 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 20:09:56 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 20:09:56 INFO - building 'psutil._psutil_posix' extension 20:09:56 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 20:09:56 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 20:09:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:56 INFO - Successfully installed psutil 20:09:56 INFO - Cleaning up... 20:09:57 INFO - Return code: 0 20:09:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:09:57 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 20:09:57 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 20:09:57 INFO - Using env: {'DISPLAY': ':0', 20:09:57 INFO - 'HOME': '/home/cltbld', 20:09:57 INFO - 'LANG': 'en_US.UTF-8', 20:09:57 INFO - 'LANGUAGE': 'en_US:en', 20:09:57 INFO - 'LOGNAME': 'cltbld', 20:09:57 INFO - 'MAIL': '/var/mail/cltbld', 20:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:57 INFO - 'MOZ_NO_REMOTE': '1', 20:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:57 INFO - 'NO_EM_RESTART': '1', 20:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:57 INFO - 'PWD': '/builds/slave/test', 20:09:57 INFO - 'SHELL': '/bin/bash', 20:09:57 INFO - 'SHLVL': '1', 20:09:57 INFO - 'TERM': 'linux', 20:09:57 INFO - 'TMOUT': '86400', 20:09:57 INFO - 'USER': 'cltbld', 20:09:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:57 INFO - '_': '/tools/buildbot/bin/python'} 20:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09:57 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 20:09:57 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 20:09:57 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 20:09:57 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 20:09:57 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 20:09:57 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 20:09:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:59 INFO - Installing collected packages: mozsystemmonitor 20:09:59 INFO - Running setup.py install for mozsystemmonitor 20:09:59 INFO - Successfully installed mozsystemmonitor 20:09:59 INFO - Cleaning up... 20:09:59 INFO - Return code: 0 20:09:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:59 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:09:59 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 20:09:59 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 20:09:59 INFO - Using env: {'DISPLAY': ':0', 20:09:59 INFO - 'HOME': '/home/cltbld', 20:09:59 INFO - 'LANG': 'en_US.UTF-8', 20:09:59 INFO - 'LANGUAGE': 'en_US:en', 20:09:59 INFO - 'LOGNAME': 'cltbld', 20:09:59 INFO - 'MAIL': '/var/mail/cltbld', 20:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:59 INFO - 'MOZ_NO_REMOTE': '1', 20:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:59 INFO - 'NO_EM_RESTART': '1', 20:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:59 INFO - 'PWD': '/builds/slave/test', 20:09:59 INFO - 'SHELL': '/bin/bash', 20:09:59 INFO - 'SHLVL': '1', 20:09:59 INFO - 'TERM': 'linux', 20:09:59 INFO - 'TMOUT': '86400', 20:09:59 INFO - 'USER': 'cltbld', 20:09:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:59 INFO - '_': '/tools/buildbot/bin/python'} 20:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:59 INFO - Downloading/unpacking jsonschema==2.5.1 20:09:59 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 20:09:59 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 20:09:59 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 20:09:59 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 20:09:59 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 20:09:59 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 20:10:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:10:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:10:01 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 20:10:01 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 20:10:01 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 20:10:01 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 20:10:01 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 20:10:01 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 20:10:01 INFO - Downloading functools32-3.2.3-2.tar.gz 20:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:10:01 INFO - warning: no files found matching '*.txt' 20:10:01 INFO - no previously-included directories found matching 'build' 20:10:01 INFO - no previously-included directories found matching 'dist' 20:10:01 INFO - no previously-included directories found matching '.git*' 20:10:01 INFO - Installing collected packages: jsonschema, functools32 20:10:01 INFO - Running setup.py install for functools32 20:10:01 INFO - warning: no files found matching '*.txt' 20:10:01 INFO - no previously-included directories found matching 'build' 20:10:01 INFO - no previously-included directories found matching 'dist' 20:10:01 INFO - no previously-included directories found matching '.git*' 20:10:01 INFO - Successfully installed jsonschema functools32 20:10:01 INFO - Cleaning up... 20:10:01 INFO - Return code: 0 20:10:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:01 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:10:01 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 20:10:01 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 20:10:01 INFO - Using env: {'DISPLAY': ':0', 20:10:01 INFO - 'HOME': '/home/cltbld', 20:10:01 INFO - 'LANG': 'en_US.UTF-8', 20:10:01 INFO - 'LANGUAGE': 'en_US:en', 20:10:01 INFO - 'LOGNAME': 'cltbld', 20:10:01 INFO - 'MAIL': '/var/mail/cltbld', 20:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:01 INFO - 'MOZ_NO_REMOTE': '1', 20:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:01 INFO - 'NO_EM_RESTART': '1', 20:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:01 INFO - 'PWD': '/builds/slave/test', 20:10:01 INFO - 'SHELL': '/bin/bash', 20:10:01 INFO - 'SHLVL': '1', 20:10:01 INFO - 'TERM': 'linux', 20:10:01 INFO - 'TMOUT': '86400', 20:10:01 INFO - 'USER': 'cltbld', 20:10:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:01 INFO - '_': '/tools/buildbot/bin/python'} 20:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:02 INFO - Downloading/unpacking blobuploader==1.2.4 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:02 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 20:10:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:10:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:10:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 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 20:10:04 INFO - Downloading docopt-0.6.1.tar.gz 20:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:10:04 INFO - Installing collected packages: blobuploader, requests, docopt 20:10:04 INFO - Running setup.py install for blobuploader 20:10:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:10:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:10:04 INFO - Running setup.py install for requests 20:10:05 INFO - Running setup.py install for docopt 20:10:05 INFO - Successfully installed blobuploader requests docopt 20:10:05 INFO - Cleaning up... 20:10:05 INFO - Return code: 0 20:10:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:05 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')]} 20:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:05 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')]} 20:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:05 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:10:05 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 20:10:05 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 20:10:05 INFO - Using env: {'DISPLAY': ':0', 20:10:05 INFO - 'HOME': '/home/cltbld', 20:10:05 INFO - 'LANG': 'en_US.UTF-8', 20:10:05 INFO - 'LANGUAGE': 'en_US:en', 20:10:05 INFO - 'LOGNAME': 'cltbld', 20:10:05 INFO - 'MAIL': '/var/mail/cltbld', 20:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:05 INFO - 'MOZ_NO_REMOTE': '1', 20:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:05 INFO - 'NO_EM_RESTART': '1', 20:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:05 INFO - 'PWD': '/builds/slave/test', 20:10:05 INFO - 'SHELL': '/bin/bash', 20:10:05 INFO - 'SHLVL': '1', 20:10:05 INFO - 'TERM': 'linux', 20:10:05 INFO - 'TMOUT': '86400', 20:10:05 INFO - 'USER': 'cltbld', 20:10:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:05 INFO - '_': '/tools/buildbot/bin/python'} 20:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:05 INFO - Running setup.py (path:/tmp/pip-8E7h5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:05 INFO - Running setup.py (path:/tmp/pip-kKE9pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:05 INFO - Running setup.py (path:/tmp/pip-5RvmHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:05 INFO - Running setup.py (path:/tmp/pip-QiuIjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:05 INFO - Running setup.py (path:/tmp/pip-QRjm3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:05 INFO - Running setup.py (path:/tmp/pip-K8hjPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:06 INFO - Running setup.py (path:/tmp/pip-tR_dNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:06 INFO - Running setup.py (path:/tmp/pip-8eLwCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:06 INFO - Running setup.py (path:/tmp/pip-4J7HXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:06 INFO - Running setup.py (path:/tmp/pip-yAn6DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:06 INFO - Running setup.py (path:/tmp/pip-5qaPev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:06 INFO - Running setup.py (path:/tmp/pip-sSAQrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:06 INFO - Running setup.py (path:/tmp/pip-OYQob9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:06 INFO - Running setup.py (path:/tmp/pip-YF8GHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:06 INFO - Running setup.py (path:/tmp/pip-0bi0mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:06 INFO - Running setup.py (path:/tmp/pip-Pa9AcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:06 INFO - Running setup.py (path:/tmp/pip-cv38gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:10:06 INFO - Running setup.py install for manifestparser 20:10:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:10:06 INFO - Running setup.py install for mozcrash 20:10:07 INFO - Running setup.py install for mozdebug 20:10:07 INFO - Running setup.py install for mozdevice 20:10:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Running setup.py install for mozfile 20:10:07 INFO - Running setup.py install for mozhttpd 20:10:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Running setup.py install for mozinfo 20:10:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Running setup.py install for mozInstall 20:10:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Running setup.py install for mozleak 20:10:07 INFO - Running setup.py install for mozlog 20:10:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:10:07 INFO - Running setup.py install for moznetwork 20:10:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:10:08 INFO - Running setup.py install for mozprocess 20:10:08 INFO - Running setup.py install for mozprofile 20:10:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:10:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:10:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:10:08 INFO - Running setup.py install for mozrunner 20:10:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:10:08 INFO - Running setup.py install for mozscreenshot 20:10:08 INFO - Running setup.py install for moztest 20:10:08 INFO - Running setup.py install for mozversion 20:10:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:10:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:10:08 INFO - Cleaning up... 20:10:08 INFO - Return code: 0 20:10:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10: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')]} 20:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10: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')]} 20:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:08 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:10:08 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 20:10:08 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 20:10:08 INFO - Using env: {'DISPLAY': ':0', 20:10:08 INFO - 'HOME': '/home/cltbld', 20:10:08 INFO - 'LANG': 'en_US.UTF-8', 20:10:08 INFO - 'LANGUAGE': 'en_US:en', 20:10:08 INFO - 'LOGNAME': 'cltbld', 20:10:08 INFO - 'MAIL': '/var/mail/cltbld', 20:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:08 INFO - 'MOZ_NO_REMOTE': '1', 20:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:08 INFO - 'NO_EM_RESTART': '1', 20:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:08 INFO - 'PWD': '/builds/slave/test', 20:10:08 INFO - 'SHELL': '/bin/bash', 20:10:08 INFO - 'SHLVL': '1', 20:10:08 INFO - 'TERM': 'linux', 20:10:08 INFO - 'TMOUT': '86400', 20:10:08 INFO - 'USER': 'cltbld', 20:10:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:08 INFO - '_': '/tools/buildbot/bin/python'} 20:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:10:08 INFO - Running setup.py (path:/tmp/pip-ooyFME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:10:08 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)) 20:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:10:08 INFO - Running setup.py (path:/tmp/pip-jGfzYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:10:09 INFO - Running setup.py (path:/tmp/pip-L1NVEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:10:09 INFO - Running setup.py (path:/tmp/pip-M9zpcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:10:09 INFO - Running setup.py (path:/tmp/pip-VeEDix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:10:09 INFO - Running setup.py (path:/tmp/pip-A0gCT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:10:09 INFO - Running setup.py (path:/tmp/pip-OZpdsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:10:09 INFO - Running setup.py (path:/tmp/pip-TQG6mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:10:09 INFO - Running setup.py (path:/tmp/pip-2CTb3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:10:09 INFO - Running setup.py (path:/tmp/pip-LJJyUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:10:09 INFO - Running setup.py (path:/tmp/pip-TSOgGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:10:09 INFO - Running setup.py (path:/tmp/pip-tgdkWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:10:09 INFO - Running setup.py (path:/tmp/pip-2jrhYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:10:09 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:10:09 INFO - Running setup.py (path:/tmp/pip-5pEvRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 20:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:09 INFO - Running setup.py (path:/tmp/pip-A1F_32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:10:10 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)) 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:10:10 INFO - Running setup.py (path:/tmp/pip-mmSdTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:10:10 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)) 20:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:10:10 INFO - Running setup.py (path:/tmp/pip-HaOXnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 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)) 20:10:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:12 INFO - Downloading blessings-1.6.tar.gz 20:10:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:10:12 INFO - Installing collected packages: blessings 20:10:12 INFO - Running setup.py install for blessings 20:10:12 INFO - Successfully installed blessings 20:10:12 INFO - Cleaning up... 20:10:12 INFO - Return code: 0 20:10:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:12 INFO - Reading from file tmpfile_stdout 20:10:12 INFO - Current package versions: 20:10:12 INFO - argparse == 1.2.1 20:10:12 INFO - blessings == 1.6 20:10:12 INFO - blobuploader == 1.2.4 20:10:12 INFO - docopt == 0.6.1 20:10:12 INFO - functools32 == 3.2.3-2 20:10:12 INFO - jsonschema == 2.5.1 20:10:12 INFO - manifestparser == 1.1 20:10:12 INFO - mozInstall == 1.12 20:10:12 INFO - mozcrash == 0.17 20:10:12 INFO - mozdebug == 0.1 20:10:12 INFO - mozdevice == 0.48 20:10:12 INFO - mozfile == 1.2 20:10:12 INFO - mozhttpd == 0.7 20:10:12 INFO - mozinfo == 0.9 20:10:12 INFO - mozleak == 0.1 20:10:12 INFO - mozlog == 3.2 20:10:12 INFO - moznetwork == 0.27 20:10:12 INFO - mozprocess == 0.22 20:10:12 INFO - mozprofile == 0.28 20:10:12 INFO - mozrunner == 6.11 20:10:12 INFO - mozscreenshot == 0.1 20:10:12 INFO - mozsystemmonitor == 0.3 20:10:12 INFO - moztest == 0.7 20:10:12 INFO - mozversion == 1.4 20:10:12 INFO - psutil == 3.1.1 20:10:12 INFO - requests == 1.2.3 20:10:12 INFO - wsgiref == 0.1.2 20:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:10:12 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')]} 20:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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')]} 20:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:10:12 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 20:10:12 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 20:10:12 INFO - Using env: {'DISPLAY': ':0', 20:10:12 INFO - 'HOME': '/home/cltbld', 20:10:12 INFO - 'LANG': 'en_US.UTF-8', 20:10:12 INFO - 'LANGUAGE': 'en_US:en', 20:10:12 INFO - 'LOGNAME': 'cltbld', 20:10:12 INFO - 'MAIL': '/var/mail/cltbld', 20:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:12 INFO - 'MOZ_NO_REMOTE': '1', 20:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:12 INFO - 'NO_EM_RESTART': '1', 20:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:12 INFO - 'PWD': '/builds/slave/test', 20:10:12 INFO - 'SHELL': '/bin/bash', 20:10:12 INFO - 'SHLVL': '1', 20:10:12 INFO - 'TERM': 'linux', 20:10:12 INFO - 'TMOUT': '86400', 20:10:12 INFO - 'USER': 'cltbld', 20:10:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:12 INFO - '_': '/tools/buildbot/bin/python'} 20:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 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)) 20:10:12 INFO - Cleaning up... 20:10:12 INFO - Return code: 0 20:10:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:10:12 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')]} 20:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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')]} 20:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:10:12 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 20:10:12 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 20:10:12 INFO - Using env: {'DISPLAY': ':0', 20:10:12 INFO - 'HOME': '/home/cltbld', 20:10:12 INFO - 'LANG': 'en_US.UTF-8', 20:10:12 INFO - 'LANGUAGE': 'en_US:en', 20:10:12 INFO - 'LOGNAME': 'cltbld', 20:10:12 INFO - 'MAIL': '/var/mail/cltbld', 20:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:12 INFO - 'MOZ_NO_REMOTE': '1', 20:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:12 INFO - 'NO_EM_RESTART': '1', 20:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:12 INFO - 'PWD': '/builds/slave/test', 20:10:12 INFO - 'SHELL': '/bin/bash', 20:10:12 INFO - 'SHLVL': '1', 20:10:12 INFO - 'TERM': 'linux', 20:10:12 INFO - 'TMOUT': '86400', 20:10:12 INFO - 'USER': 'cltbld', 20:10:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:12 INFO - '_': '/tools/buildbot/bin/python'} 20:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:10:12 INFO - Cleaning up... 20:10:12 INFO - Return code: 0 20:10:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:10:12 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')]} 20:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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')]} 20:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:10:12 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 0x7f5df1b0ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', '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 20:10:12 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 20:10:12 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 20:10:12 INFO - Using env: {'DISPLAY': ':0', 20:10:12 INFO - 'HOME': '/home/cltbld', 20:10:12 INFO - 'LANG': 'en_US.UTF-8', 20:10:12 INFO - 'LANGUAGE': 'en_US:en', 20:10:12 INFO - 'LOGNAME': 'cltbld', 20:10:12 INFO - 'MAIL': '/var/mail/cltbld', 20:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:12 INFO - 'MOZ_NO_REMOTE': '1', 20:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:12 INFO - 'NO_EM_RESTART': '1', 20:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:12 INFO - 'PWD': '/builds/slave/test', 20:10:12 INFO - 'SHELL': '/bin/bash', 20:10:12 INFO - 'SHLVL': '1', 20:10:12 INFO - 'TERM': 'linux', 20:10:12 INFO - 'TMOUT': '86400', 20:10:12 INFO - 'USER': 'cltbld', 20:10:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:12 INFO - '_': '/tools/buildbot/bin/python'} 20:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:10:13 INFO - Downloading/unpacking flake8 20:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:10:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:10:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:15 INFO - no previously-included directories found matching 'docs/_build' 20:10:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:10:15 INFO - Running setup.py install for pep8 20:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:10:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:10:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:10:15 INFO - no previously-included directories found matching 'docs/_build' 20:10:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:10:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:10:16 INFO - Cleaning up... 20:10:16 INFO - Return code: 0 20:10:16 INFO - Running post-action listener: _resource_record_post_action 20:10:16 INFO - Running post-action listener: _start_resource_monitoring 20:10:16 INFO - Starting resource monitoring. 20:10:16 INFO - ##### 20:10:16 INFO - ##### Finished create-virtualenv step (success) 20:10:16 INFO - ##### 20:10:16 INFO - ##### 20:10:16 INFO - ##### Running install step. 20:10:16 INFO - ##### 20:10:16 INFO - Running pre-action listener: _resource_record_pre_action 20:10:16 INFO - Running main action method: install 20:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:10:16 INFO - Reading from file tmpfile_stdout 20:10:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:10:16 INFO - Reading from file tmpfile_stdout 20:10:16 INFO - Output received: 20:10:16 INFO - Usage: mozinstall [options] installer 20:10:16 INFO - Options: 20:10:16 INFO - -h, --help show this help message and exit 20:10:16 INFO - -d DEST, --destination=DEST 20:10:16 INFO - Directory to install application into. [default: 20:10:16 INFO - "/builds/slave/test"] 20:10:16 INFO - --app=APP Application being installed. [default: firefox] 20:10:16 INFO - mkdir: /builds/slave/test/build/application 20:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:10:32 INFO - Reading from file tmpfile_stdout 20:10:32 INFO - Output received: 20:10:32 INFO - /builds/slave/test/build/application/firefox/firefox 20:10:32 INFO - Running post-action listener: _resource_record_post_action 20:10:32 INFO - ##### 20:10:32 INFO - ##### Finished install step (success) 20:10:32 INFO - ##### 20:10:32 INFO - ##### 20:10:32 INFO - ##### Running run-tests step. 20:10:32 INFO - ##### 20:10:32 INFO - Running pre-action listener: _resource_record_pre_action 20:10:32 INFO - Running main action method: run_tests 20:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:10:32 INFO - Python 2.7.3 20:10:32 INFO - Return code: 0 20:10:32 INFO - grabbing minidump binary from tooltool 20:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:10:32 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 0x28771c0>, '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 0x28780c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2878550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:10:32 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 20:10:32 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 20:10:32 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 20:10:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:32 INFO - Return code: 0 20:10:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:10:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:10:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:10:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:10:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:10:33 INFO - Return code: 0 20:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 20:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 20:10:33 INFO - Using env: {'DISPLAY': ':0', 20:10:33 INFO - 'HOME': '/home/cltbld', 20:10:33 INFO - 'LANG': 'en_US.UTF-8', 20:10:33 INFO - 'LANGUAGE': 'en_US:en', 20:10:33 INFO - 'LOGNAME': 'cltbld', 20:10:33 INFO - 'MAIL': '/var/mail/cltbld', 20:10:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:10:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:33 INFO - 'MOZ_NO_REMOTE': '1', 20:10:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:10:33 INFO - 'NO_EM_RESTART': '1', 20:10:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:33 INFO - 'PWD': '/builds/slave/test', 20:10:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:10:33 INFO - 'SHELL': '/bin/bash', 20:10:33 INFO - 'SHLVL': '1', 20:10:33 INFO - 'TERM': 'linux', 20:10:33 INFO - 'TMOUT': '86400', 20:10:33 INFO - 'USER': 'cltbld', 20:10:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864', 20:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:33 INFO - '_': '/tools/buildbot/bin/python'} 20:10:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 20:10:33 INFO - mozversion application_buildid: 20160707173525 20:10:33 INFO - mozversion application_changeset: 0f0647de29598b4d556e32372612329a9d743a12 20:10:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:10:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:33 INFO - mozversion application_name: Firefox 20:10:33 INFO - mozversion application_remotingname: firefox-dev 20:10:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:10:33 INFO - mozversion application_vendor: Mozilla 20:10:33 INFO - mozversion application_version: 49.0a2 20:10:33 INFO - mozversion platform_buildid: 20160707173525 20:10:33 INFO - mozversion platform_changeset: 0f0647de29598b4d556e32372612329a9d743a12 20:10:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:10:33 INFO - mozversion platform_version: 49.0a2 20:10:33 INFO - using testdate: 1467947433 20:10:33 INFO - actual date: 1467947433 20:10:33 INFO - starting webserver on 'localhost:44833' 20:10:33 INFO - SUITE-START | Running 2 tests 20:10:33 INFO - TEST-START | dromaeo_css 20:10:33 INFO - operating with platform_type : linux_ 20:10:33 INFO - Initialising browser for dromaeo_css test... 20:10:33 INFO - TEST-INFO | started process 11846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5L2Wln/profile http://localhost:44833/getInfo.html) 20:10:37 INFO - PROCESS | 11846 | __metrics Screen width/height:1600/1200 20:10:37 INFO - PROCESS | 11846 | colorDepth:24 20:10:37 INFO - PROCESS | 11846 | Browser inner width/height: 1024/697 20:10:37 INFO - PROCESS | 11846 | __metrics 20:10:38 ERROR - PROCESS | 11846 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 20:10:39 INFO - TEST-INFO | 11846: exit 0 20:10:39 INFO - Browser initialized. 20:10:39 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:39 INFO - TEST-INFO | started process 11973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5L2Wln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:50 INFO - PROCESS | 11973 | RSS: Main: 155828224 20:10:50 INFO - PROCESS | 11973 | 20:11:40 INFO - PROCESS | 11973 | 1467947500359 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] 20:13:48 INFO - PROCESS | 11973 | Cycle 1(1): loaded http://localhost:44833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44833/tests/dromaeo/cssquery-ext.html) 20:13:49 INFO - PROCESS | 11973 | RSS: Main: 159977472 20:13:49 INFO - PROCESS | 11973 | 20:16:51 INFO - PROCESS | 11973 | Cycle 1(1): loaded http://localhost:44833/tests/dromaeo/cssquery-ext.html (next: http://localhost:44833/tests/dromaeo/cssquery-jquery.html) 20:16:51 INFO - PROCESS | 11973 | RSS: Main: 157429760 20:16:51 INFO - PROCESS | 11973 | 20:19:53 INFO - PROCESS | 11973 | Cycle 1(1): loaded http://localhost:44833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44833/tests/dromaeo/cssquery-mootools.html) 20:19:54 INFO - PROCESS | 11973 | RSS: Main: 157392896 20:19:54 INFO - PROCESS | 11973 | 20:22:55 INFO - PROCESS | 11973 | Cycle 1(1): loaded http://localhost:44833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44833/tests/dromaeo/cssquery-prototype.html) 20:22:56 INFO - PROCESS | 11973 | RSS: Main: 156897280 20:22:56 INFO - PROCESS | 11973 | 20:25:58 INFO - PROCESS | 11973 | Cycle 1(1): loaded http://localhost:44833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44833/tests/dromaeo/cssquery-yui.html) 20:25:59 INFO - PROCESS | 11973 | RSS: Main: 158748672 20:25:59 INFO - PROCESS | 11973 | 20:29:01 INFO - PROCESS | 11973 | Cycle 1(1): loaded http://localhost:44833/tests/dromaeo/cssquery-yui.html (next: http://localhost:44833/tests/dromaeo/cssquery-dojo.html) 20:29:02 INFO - PROCESS | 11973 | RSS: Main: 159318016 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | __start_tp_report 20:29:02 INFO - PROCESS | 11973 | _x_x_mozilla_page_load 20:29:02 INFO - PROCESS | 11973 | _x_x_mozilla_page_load_details 20:29:02 INFO - PROCESS | 11973 | |i|pagename|runs| 20:29:02 INFO - PROCESS | 11973 | |0;dojo.html;3340.6826351496607;3381.289929114885;3389.1188291044323;3409.267007593365;3417.897463076107;5531.695756733378;5533.474319939604;5585.078462053756;5644.238027866247;5647.491725744682;5652.63257888237;5689.203511508392;5700.201971723952;5718.199452076702;5739.397363276858;5145.845624631267;5196.934628401187;5247.055530004598;5247.239150323201;5270.341207349082;5042.092423363793;5062.746862656871;5145.6398052136365;5301.469853014706;5306.761195746181;5099.260607211952;5152.92270615941;5162.690238585678;5193.948060519403;5197.0905091609;5159.638825282232;5167.586593072583;5194.584433245332;5247.632665713401;5286.841394758163;4961.5038496150455;5122.231665250242;5200;5237.607179461517;5254.763535640867;5456.863578410532;5464.398916119224;5525.281713377275;5536.7231638418325;5584.0507113790345;5964.880702385928;6006.399360064002;6011.6393016418715;6087.1173679816175;6095.08573713942;5879.617824841414;6077.574569780118;6145.047517634774;6150.04674275488;6158.230221222348;5743.339515955677;5773.9422605773825;5804.361520232771;5806.680632565207;5811.215485909391;6235.158253635792;6303.180586523723;6311.800757855993;6325.399087086719;6338.397852204033;5908;5936.7922122725495;5981.820545383558;6089.8477538061015;6094.786682466181;6160.075988601656;6172.969135154385;6180.907286390708;6184.350643182401;6188.504919606421;6047.365026672224;6100.48145907594;6125.9693701531205;6132.356102609251;6133.355997620186;5894.204282421904;5901.911471327933;5945.375735547792;5949.375315591887;6074.51403887688;4609.677322587387;4634.884127896829;4656.743879086615;4664.766761661971;4691.882702932454;4163;4171.124063946605;4174.686898482626;4199.622034016953;4199.9370009449885;5602.887942241132;5734.340550836707;5827.3007239131575;5849.151872978395;5874.853128671817;6038.879222415527;6118.162361256266;6128.717018009172;6130.321737090849;6141.570090093651;5691.430856914359;5854.736536855852;5856.531477481792;5859.062549991981;5874.823755287262;5170.250313704491;5201.817936372209;5207.270982062514;5207.869803254949;5214.869628259324;6301.4328710416285;6320.178376811077;6322;6341.239051313872;6446.258680251737;5945.583809133319;6094.969525152346;6125.877482450326;6171.259448866164;6178.41305076017;6353.174087368612;6450.451711604378;6451.677416129269;6473.805785826433;6473.967630161819;5982.162497250475;5988.8802223956145;6016.518678505621;6025.096235564701;6042.637441753509;5988.341282459013;6028.849278768066;6056.424639659225;6162.445379915829;6164.630122192682;5946.048632218824;5981.162637230704;5992.730327135377;5997.940020599913;6005.759769609167;5910.438508341701;5923.4076592340425;5923.911141332969;5990.760369585168;6015.6691381974415;5654.943450565442;5824.912626310524;5872.530197584098;5877.353491115889;5929.347771745019;6021.337652858095;6045.395460454095;6095.542834287535;6099.237595300588;6114.510839132769;5885.735141918538;5924.052151655715;5927.347991720821;5989.8203053908455;5989.8203053908455 20:29:02 INFO - PROCESS | 11973 | |1;ext.html;594.7145370222294;615.8706671598964;650.6616559389117;660.6234446365571;674.9628770417628;44856.77571612142;46092.76953615227;46123.76938115309;46208.76895615521;49879;47307;47805.52194478054;48021.7598912005;48110.27834582475;48200.27699584509;8886.555672216396;8999.100089990981;9001.77495562613;9002.954985225064;9051.864222036675;8956.462612243286;8960.23837973773;9011.684591039315;9026.954865225698;9042.683506077288;9044.819103617923;9046.411983221102;9113.772155696095;9117.179453849152;9118.17936385725;8928.330375221853;9002.234810041155;9018.86471702925;9021.639134434614;9050.773730656787;8880.067592902782;8892.510911899843;8908.06465321145;8911.287097032287;8949.59726812295;43918.56081439208;44077.55922440767;44125.117497650186;44195;44416.667499975054;3637.236180402119;3735.4957080794015;3773.2642134783728;3891.8248678809523;4196.685248606367;32957.835210823796;33144.50283245753;33537.32925341504;33705.49441758376;33912.49131263008;4214.966256450979;4260.424842646234;4297.97851010746;4322.7190232634775;4397.406350142722;265814;266160;266180;266195;266368;33673.66326336705;60826;61433.69283153645;61529.69235153795;61639.69180154071;40857.182856342704;41119;41228.38157427641;41243.1751364971;41419;16419.58951026234;16867.072311022766;16977.236024378934;16980.660386792442;16993;13945.58163255104;13945.65135871591;14050.508232211823;14076;14090.788638170436;9156;9185.081491850895;9205.447673139633;9269.72190834276;9331.066893310615;3478.1826270826336;3538.097785064792;3546.361654902091;3550.396432606463;3587;1075.3010543147018;1096.1121491591837;1139.2879450343535;1144.1133121830649;1196.1387800783596;33783.66216337854;34047.659523404946;34064.14839629029;34276.31447371088;34320.82839585786;1128.9943550282196;1163.6101905861462;1175.5415387998687;1221.3954092723982;1253.0915086562352;17795.110244487725;17807.46577602674;17865.910670446563;17882.91058544725;17934.923904565767;557377;861695;863973;954306;961370;61031;61967.690161548904;62026.689866550376;62346;62407;1468.6768910839598;1501.2868887278673;1506.7965824613757;1518.3395223077996;1522.8173118183051;30505.694943051174;31191;31817;31884.840575796974;32466.188345291557;51270;51968.220476693634;52379.21431178611;52407.73796130995;52498.73750631375;394877;395410;395991;398063;399908;29285.70714292915;29603.703962960095;29724.554131688474;29777.85111074431;29807.55288670715;46925;47591.52408475871;48066.5193348062;48702.26946595875;49146.75426622844;40316.1936761269;40816.59183408128;41056.58943410528;41094.38358424686;41383.793081034404;38856.61143388643;40117.79941100276;40294.19411611693;40732.389014165405;42880;43682.34476482792;43829;43903.560964389944;44466.55533444624;44575.55424445714;37681.43477847889;38184.618153818104;38203.80898095492;38793.224135517696;39012.60987390203;29246.415071698022;29859;29926;30034.699653004063;30245 20:29:02 INFO - PROCESS | 11973 | |2;jquery.html;418.4998926283091;425.4745389444037;431.80784550874876;434.72612254279807;444.69316171841444;17737.467875963725;18939.33712320069;19559.706604400926;19646.607067858633;19927.302544410948;18838.811611883877;19161.42515724527;19444.222231110773;19831;19922.90038549805;5502.532284755801;5684.289463817023;5847.912281315784;5851.912221316684;5857.062869940811;5567.749451274703;5684.317881854163;5709.74306156224;5758.193852860602;5765.394633563478;5797.869415463986;5798.449147331018;5801.593888427812;5807.796727114552;5811.157382179582;5659.886802263973;5750.079987202049;5766.769329226805;6900.7929762107215;7346.669399877019;7126.0736104306625;7153.642317884137;7161.248068952789;7177.174624918149;7197.316254955771;23508.294751157493;24492.265232043068;25162.24513264605;26293.34266643349;26489.602655960178;2414.360194548446;2517.848929064262;2608.4652646207483;2672.4521473097966;2742.478929003503;15900.840991590052;16739.330426782915;16859.578510537212;16879.66240675192;16926.23831927566;2171.2400659769114;2184.5740080684272;2195.560887822426;2262.751097379287;2306.4810417656063;102537;106083.46958265237;110044;110266;110754;18082.63834723298;18664.813351866578;18829.90585047066;18912.148953297135;18922.716159257623;34356.14109647279;34506.309873802384;34737.82631086828;34875.12812179665;35002.474962875574;10235.795284094276;10694.786104277871;10740.516676749565;10814.56741730322;10895.673129806119;8882.06738292483;8882.111788821196;8934.24058954983;9004.549772511347;9072.004159085123;9311.348205625542;9346.859797103049;9368.625254989724;9412;9450.669226577036;3634.8727794527063;3700.1119731264303;3712.5916149223563;3831.444440556104;3917.4123881418013;949.7103383468109;1001.9048190421898;1038.314712289885;1092.792369449802;1120.7310245541012;17310.307587696352;18589.44231673052;18755.531111722317;19334.516637084187;19386.418407447516;1032.2670903658486;1035.9689209323733;1055.2507719519074;1104.5968221599057;1105.530149686396;10572.735681607868;10908.61819836302;10987;11003.61487347939;11012.39431831257;536571;543464;545980;560306;575373;95756.52121739347;96670;97944;98028;100683.49658251661;1048.895110488945;1083.4799296337644;1132.7168207948014;1159.756451145269;1159.8492196014465;17064;17365.73951390705;17384.304627814745;17484.47546573605;17612.91193544024;41643;41681.58318416898;42361.57638423699;42576.08407621727;43022.784886075366;58259.4174058254;59684.403155967884;60312;60375.698121509115;61345.38654613397;5602.551795856403;7606.847863042819;7830.843383132419;8089.312408445113;9033.503157326148;12085.577004804789;13601.523946661819;13637.863621364057;13664.726705465637;13671.38478768438;11486.483108259981;11656.88343116558;11847.466863990969;11868.10989175798;12024.218425802295;7752.573608451589;7902.762917112495;11536.36549989725;11583.942080289544;11754.882451175721;11983.880161198276;12119.697007574881;12132.454039568063;12419.875801242233;12423.937880310903;8092.71675491355;8160.795980100545;8186.058603260702;8189.181081891763;8295.336373090018;11629.59296424621;12013.75972480528;12107.878921210675;12138.939305303416;12184.268943863397 20:29:02 INFO - PROCESS | 11973 | |3;mootools.html;1543.529223586806;1577.5267419774068;1746.799118101418;1838.880472769269;1860.2558976409434;8176.345892328614;8688.565571721405;8846.071162527931;9230;9302.86045709314;8800.77998050049;8885.86671199931;8965.28277737781;9017.909820901788;9129.452232866033;2313.097891822191;2336.894839732208;2338.929832105031;2340.3681006128336;2344.7186337639505;2238.1942500699734;2255.1768604459335;2272.284230467406;2272.5114100468395;2274.1585613323095;2249.4488850231714;2262.909483620653;2270.977290227093;2273.943151421211;2285.1773361589812;2322.500662357593;2365.491419344849;2376.714794224687;2382.7855493005713;2385.6540801583847;2422.176460003607;2425.333033415807;2439.6462512935705;2445.596476581362;2460.052879641333;8933.553322333857;8984.775380615472;8992.055834137453;9012.909870901272;9086.45481271126;5385.138377859524;5401.3248343957;5478.643888147298;5484.287042684466;5577.163425486169;3430.1081718753053;3443.070370999841;3516.525269088666;3519.3137338219058;3521.014116047485;1065.4140222877386;1084.3439718970067;1148.4544841200448;1151.2977083978767;1154.4516354731436;13232.27222502762;13266.469341226339;13364.06451548392;13398.330083495885;13406.195628262336;4859.732714700725;4962.255661650781;5003.424606170337;5042.546170844568;5043.117454445457;11103.666889993314;11162;11178.832317515244;11222.607208747655;11228.214025018333;5688.943110568841;5691.4877661010705;5692.715364231772;5716.657000579979;5729.28383952006;4436.911261774746;4968.726720030433;5064.46823083571;5137.9743101285;5145.871353216199;4304.4834619845815;4344.087741574242;4390.846320378835;4422.84520041797;4436.733795972252;1346.4479563378968;1371.4582739817915;1384.6746014686541;1393.0596847128147;1409.0911362171341;952.7760976170595;1061.946902654864;1066.2056767707952;1068.7755571330108;1082.6968448834339;6284.4344009039405;6432.807015789534;6447.323031081763;6447.968325067966;6562.835929101715;474.3454033433839;476.72111814588163;476.77114984807486;498.40938487891964;499.93500844889934;4437.5784300491405;4464.2187617166865;4476.395686582335;4479.484859241229;4574.725516469022;11153.776924461465;11322.150838686966;11429.371384573928;11475.139364547693;11527.942360288313;10958.945205273923;11084.00243978046;11181.664550063511;11496.712582185344;11503.309801411942;8216.137305582948;8224.671013159526;8282.213189746964;8320.209580089882;8348.457350272212;6178.567500274938;6257.78097766576;6272.780452684134;6316.810495685137;6359.904601431075;10390.22073344487;10516.894831051897;10654.73363165927;10697.572097116028;10697.786044278915;10547.630832920811;10735.785284294114;10786.298890572089;10892.727681808019;10924.726881828017;7378.667959941708;7831.765047048598;7860.84278314442;8042.437029407885;8423;9266.583003764712;9280.303977201871;9298.674546390845;9337.253019758538;9344.95327523358;8128.9593552031865;8351.624176911931;8358.916410835815;8438.324934005388;8496.745097647081;7873.0945941215205;7938.3252423544645;8111.634976426193;8180.059293181361;8298.128696487023;7356.77929662111;7375.963120184365;7386.556806591621;7444.218357072429;7475.476716629783;5352.437994010573;5400.648957817729;5404.297441332759;5495.890082198413;5588.944110558842;5567.025770490229;5664.461876121762;5709.429057094258;5745.626534275259;5788.305403351625 20:29:02 INFO - PROCESS | 11973 | |4;prototype.html;335.284168300678;342.3768740891577;343.63402975830724;344.39558574701425;345.86684126611254;5526.806561770339;5569.805056823007;5639.674676451041;5709.942900570998;5809.854753631156;5580.441955804417;5607.439256074391;5625.606207565472;5637.307563545884;5665.660060396369;4436.223660859353;4444.33334999751;4466.33005049242;4477.171723231205;4491.820327186909;4363.127374525092;4394.165108629366;4427.358033085201;4451.755153466558;4461.888452788674;4336.956630433702;4374.234508960935;4390.42924419825;4400.6259467945265;4425.933610995838;4419.911601767946;4419.922636360921;4430.759387371541;4437.290033594625;4437.667174961858;3711.6102809204913;3826.7129965252716;3838.098046958962;3859.826307816155;3875.360565506688;5472.1244600864065;5489.204065410533;5499.945000549983;5502.477264659851;5505.366882808488;5017;5027.220780778948;5056.6852618319135;5083.61872859537;5107.387113546361;5705.372409035002;5948.643081415085;5954.55340849438;5977.701114944235;5978.910316345258;4266.360045993126;4277.508086570022;4282.721623094489;4289.849855255051;4291.527931927485;5990.700464976778;6113.57204995655;6180.443760061571;6230.065490176465;6293.024581189923;4311.676624253194;4315.331123675835;4321.891952701208;4338.47938247406;4353.956460435418;4381.2332841753205;4383.890402739957;4399.934000989988;4405.140997505456;4410.757408342508;4770.332153498513;5028.396592408862;5045.596352291808;5049.84850454487;5079.923801142986;5746.2529871116485;5809.331926828384;5869.941300586939;5870.7945221917025;5886.823395298148;1480.6298425393652;1500.6023403798001;1505.6913332766756;1509.2001239343165;1523.2459932333566;946.9053094690476;950.1258841865363;966.9661561845302;967.8917639303099;975.9853602195973;5139.357580302462;5153.3558305211845;5154.458781827854;5161.329027226437;5177.948220517822;5422.891542169214;5423.647462914898;5446.700431476307;5503.981763373788;5519.69641669704;4947.6289278304275;5069.997351046316;5071.54356107952;5132.615053870974;5251.55582214894;2868.6557613086147;2881.1644623059497;2972.9256768580526;2973.52423612221;2979.791414600957;5546.7781288748;5574.219609254707;5604.766951270714;5611.3266408031295;5628.493435590734;5347.834127178499;5550.528205102531;5579.442055794388;5582.525485333711;5595.63628364155;5627.296587926509;5692.324607434416;5699.572532060112;5706.800261990894;5756.5682573807135;5094.312267843942;5317.229001794795;5327.946720532745;5409.295352323838;5455.563554915677;5346.812861549827;5350.491703288181;5351.117065684274;5368.865778355573;5370.711029353005;5598.544378461548;5604.719764011865;5610.4670056344585;5648.63283886546;5671.461211184931;3691.778493290411;3880.631340022693;3925.2149570085526;3939.6060393960374;4008.4588580542422;5409.377921538916;5418.864528386822;5505.724713764376;5963.344032156546;6223.284322302812;5972.761089556369;5998.310194327708;6028.969855150696;6031.879362412639;6060;5960.433758792908;6003.8386180975685;6025.517958563392;6035.366286540026;6057.363976782374;5630.605857590093;5821.534277257894;5871.412858714094;5904.852378690567;5946.494547963299;5965.1209868891165;6023.969880150571;6038.849028774316;6040.909386359296;6045.425684559959;5617.943820561742;5886.558508111823;5943.970280148572;5950.851228719317;5978.103284507359 20:29:02 INFO - PROCESS | 11973 | |5;yui.html;717.1716667249323;738.2174894611716;800.279748226596;819.414118904983;887.5828360670484;15934.282957266922;17010.40463583775;17162.828371716278;17246.137693115357;17248.827511724863;14700;15124.924375378136;15229.238538073107;15269.160196189205;15309.311081001353;706.0538877903608;858.9656413743443;859.8495263328924;882.3779235638891;883.8762573239752;876.9956150219272;877.1491653096487;880.9339299552527;882.1046637662778;882.1178821178821;926.4811705444939;927.9211267042309;928.4243768863314;929.0755698080419;930.2790337488433;918.1782304837134;925.1812146250583;925.259792166271;926.1063074133493;926.8424367857447;670.058567712365;672.6300534705892;676.1818199978032;678.6097993653619;679.9354061364163;16022.5994350141;16095;16130.274137663833;16148.75776863348;16243.593910152222;15035.097894126387;15399.384024639001;15451.459198928096;15840.128792916385;16179.595510112224;12506.874931250662;12639.241645501208;12686.80969785454;12867.034972377109;12885.098043136984;4065.410515475269;4103.199876024147;4129.29801933672;4132.855350062733;4302.763348015857;81067.59466202631;81761;82924.75612865812;83208;84389;12084;12260.938695306466;12396.75206495865;12492.312922789151;12493.750124997448;23199.420014499774;23325.88337058304;23327.53344933092;23383.298501044996;23406.297811065695;9054.320925930582;9121.726348209564;9244.445333280024;9284;9294.767630809149;5100.897982040413;5254.868628284324;5279.683219006872;5386.865328366822;5480.287562616834;3746.100935775394;3838.788866612363;3842.51968503937;3880.902977425587;3895.7272990890365;573.2576313673719;625.2497003595703;641.7978336823885;642.1651852591706;647.8121344810047;812.1026265976011;813.3046245460165;816.7631386897851;824.4476200945381;829.5478963964654;10638.893611063944;10833.133349332034;11034.337939723642;11106.833397499044;11149.331040137618;842.5281842168405;849.1338834388889;850.8085680721788;865.7835541114721;870.8867847179953;5003.5997120230295;5152.3044389007755;5177.326947496801;5213.843584692465;5224.320838290998;73717.2628273721;89960.5501972486;113325;123103;123427.3828630851;63733.68133159305;92091.53954230186;99198.50400748095;100053;101353;86942;87322;87750.56124719336;88230.55884720535;88238.35284941334;9604;9835.311528192959;9946.751331216778;9985.251106166921;10096.394216347042;54850.45149548613;55137;55280;56266.71866640641;56417;77955;80639.19360806317;81363.59318203371;81441;81606;11612;11839.82240266414;11842.46708898119;12072.75854482888;12999.935000324938;14409.639759006108;14503.419863205776;14730.77903831422;14837.10977341363;15053.397864085315;12839.358032098544;13128.212307261594;13242.271675057964;13404.195748255135;13832.585022449342;12508.749825003268;12513.874861251272;12651.367431628198;12663.113582049167;12990.480380784662;13564;13810.10234334765;13904.652383690489;14009.509667161601;15004.174770387297;12289.508419663114;12467.563635272722;12643.620691379274;12807.089798490673;13205.141665792076;12528.561500347445;12869.871301286867;12888.548900788428;12892.548760793326;12903.677408064874 20:29:02 INFO - PROCESS | 11973 | __end_tp_report 20:29:02 INFO - PROCESS | 11973 | __start_cc_report 20:29:02 INFO - PROCESS | 11973 | _x_x_mozilla_cycle_collect,338 20:29:02 INFO - PROCESS | 11973 | __end_cc_report 20:29:02 INFO - PROCESS | 11973 | __startTimestamp1467948542022__endTimestamp 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | ------- Summary: start ------- 20:29:02 INFO - PROCESS | 11973 | Number of tests: 6 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | [#0] dojo.html Cycles:165 Average:5668.97 Median:5901.91 stddev:643.07 (10.9%) stddev-sans-first:618.56 20:29:02 INFO - PROCESS | 11973 | Values: 3340.7 3381.3 3389.1 3409.3 3417.9 5531.7 5533.5 5585.1 5644.2 5647.5 5652.6 5689.2 5700.2 5718.2 5739.4 5145.8 5196.9 5247.1 5247.2 5270.3 5042.1 5062.7 5145.6 5301.5 5306.8 5099.3 5152.9 5162.7 5193.9 5197.1 5159.6 5167.6 5194.6 5247.6 5286.8 4961.5 5122.2 5200.0 5237.6 5254.8 5456.9 5464.4 5525.3 5536.7 5584.1 5964.9 6006.4 6011.6 6087.1 6095.1 5879.6 6077.6 6145.0 6150.0 6158.2 5743.3 5773.9 5804.4 5806.7 5811.2 6235.2 6303.2 6311.8 6325.4 6338.4 5908.0 5936.8 5981.8 6089.8 6094.8 6160.1 6173.0 6180.9 6184.4 6188.5 6047.4 6100.5 6126.0 6132.4 6133.4 5894.2 5901.9 5945.4 5949.4 6074.5 4609.7 4634.9 4656.7 4664.8 4691.9 4163.0 4171.1 4174.7 4199.6 4199.9 5602.9 5734.3 5827.3 5849.2 5874.9 6038.9 6118.2 6128.7 6130.3 6141.6 5691.4 5854.7 5856.5 5859.1 5874.8 5170.3 5201.8 5207.3 5207.9 5214.9 6301.4 6320.2 6322.0 6341.2 6446.3 5945.6 6095.0 6125.9 6171.3 6178.4 6353.2 6450.5 6451.7 6473.8 6474.0 5982.2 5988.9 6016.5 6025.1 6042.6 5988.3 6028.8 6056.4 6162.4 6164.6 5946.0 5981.2 5992.7 5997.9 6005.8 5910.4 5923.4 5923.9 5990.8 6015.7 5654.9 5824.9 5872.5 5877.4 5929.3 6021.3 6045.4 6095.5 6099.2 6114.5 5885.7 5924.1 5927.3 5989.8 5989.8 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | [#1] ext.html Cycles:180 Average:65062.20 Median:41235.78 stddev:152831.72 (370.6%) stddev-sans-first:153183.81 20:29:02 INFO - PROCESS | 11973 | Values: 594.7 615.9 650.7 660.6 675.0 44856.8 46092.8 46123.8 46208.8 49879.0 47307.0 47805.5 48021.8 48110.3 48200.3 8886.6 8999.1 9001.8 9003.0 9051.9 8956.5 8960.2 9011.7 9027.0 9042.7 9044.8 9046.4 9113.8 9117.2 9118.2 8928.3 9002.2 9018.9 9021.6 9050.8 8880.1 8892.5 8908.1 8911.3 8949.6 43918.6 44077.6 44125.1 44195.0 44416.7 3637.2 3735.5 3773.3 3891.8 4196.7 32957.8 33144.5 33537.3 33705.5 33912.5 4215.0 4260.4 4298.0 4322.7 4397.4 265814.0 266160.0 266180.0 266195.0 266368.0 33673.7 60826.0 61433.7 61529.7 61639.7 40857.2 41119.0 41228.4 41243.2 41419.0 16419.6 16867.1 16977.2 16980.7 16993.0 13945.6 13945.7 14050.5 14076.0 14090.8 9156.0 9185.1 9205.4 9269.7 9331.1 3478.2 3538.1 3546.4 3550.4 3587.0 1075.3 1096.1 1139.3 1144.1 1196.1 33783.7 34047.7 34064.1 34276.3 34320.8 1129.0 1163.6 1175.5 1221.4 1253.1 17795.1 17807.5 17865.9 17882.9 17934.9 557377.0 861695.0 863973.0 954306.0 961370.0 61031.0 61967.7 62026.7 62346.0 62407.0 1468.7 1501.3 1506.8 1518.3 1522.8 30505.7 31191.0 31817.0 31884.8 32466.2 51270.0 51968.2 52379.2 52407.7 52498.7 394877.0 395410.0 395991.0 398063.0 399908.0 29285.7 29603.7 29724.6 29777.9 29807.6 46925.0 47591.5 48066.5 48702.3 49146.8 40316.2 40816.6 41056.6 41094.4 41383.8 38856.6 40117.8 40294.2 40732.4 42880.0 43682.3 43829.0 43903.6 44466.6 44575.6 37681.4 38184.6 38203.8 38793.2 39012.6 29246.4 29859.0 29926.0 30034.7 30245.0 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | [#2] jquery.html Cycles:180 Average:33009.12 Median:24827.26 stddev:91234.54 (367.5%) stddev-sans-first:91457.66 20:29:02 INFO - PROCESS | 11973 | Values: 418.5 425.5 431.8 434.7 444.7 17737.5 18939.3 19559.7 19646.6 19927.3 18838.8 19161.4 19444.2 19831.0 19922.9 5502.5 5684.3 5847.9 5851.9 5857.1 5567.7 5684.3 5709.7 5758.2 5765.4 5797.9 5798.4 5801.6 5807.8 5811.2 5659.9 5750.1 5766.8 6900.8 7346.7 7126.1 7153.6 7161.2 7177.2 7197.3 23508.3 24492.3 25162.2 26293.3 26489.6 2414.4 2517.8 2608.5 2672.5 2742.5 15900.8 16739.3 16859.6 16879.7 16926.2 2171.2 2184.6 2195.6 2262.8 2306.5 102537.0 106083.5 110044.0 110266.0 110754.0 18082.6 18664.8 18829.9 18912.1 18922.7 34356.1 34506.3 34737.8 34875.1 35002.5 10235.8 10694.8 10740.5 10814.6 10895.7 8882.1 8882.1 8934.2 9004.5 9072.0 9311.3 9346.9 9368.6 9412.0 9450.7 3634.9 3700.1 3712.6 3831.4 3917.4 949.7 1001.9 1038.3 1092.8 1120.7 17310.3 18589.4 18755.5 19334.5 19386.4 1032.3 1036.0 1055.3 1104.6 1105.5 10572.7 10908.6 10987.0 11003.6 11012.4 536571.0 543464.0 545980.0 560306.0 575373.0 95756.5 96670.0 97944.0 98028.0 100683.5 1048.9 1083.5 1132.7 1159.8 1159.8 17064.0 17365.7 17384.3 17484.5 17612.9 41643.0 41681.6 42361.6 42576.1 43022.8 58259.4 59684.4 60312.0 60375.7 61345.4 5602.6 7606.8 7830.8 8089.3 9033.5 12085.6 13601.5 13637.9 13664.7 13671.4 11486.5 11656.9 11847.5 11868.1 12024.2 7752.6 7902.8 11536.4 11583.9 11754.9 11983.9 12119.7 12132.5 12419.9 12423.9 8092.7 8160.8 8186.1 8189.2 8295.3 11629.6 12013.8 12107.9 12138.9 12184.3 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | [#3] mootools.html Cycles:180 Average:6093.91 Median:475.53 stddev:3501.11 (736.2%) stddev-sans-first:3494.23 20:29:02 INFO - PROCESS | 11973 | Values: 1543.5 1577.5 1746.8 1838.9 1860.3 8176.3 8688.6 8846.1 9230.0 9302.9 8800.8 8885.9 8965.3 9017.9 9129.5 2313.1 2336.9 2338.9 2340.4 2344.7 2238.2 2255.2 2272.3 2272.5 2274.2 2249.4 2262.9 2271.0 2273.9 2285.2 2322.5 2365.5 2376.7 2382.8 2385.7 2422.2 2425.3 2439.6 2445.6 2460.1 8933.6 8984.8 8992.1 9012.9 9086.5 5385.1 5401.3 5478.6 5484.3 5577.2 3430.1 3443.1 3516.5 3519.3 3521.0 1065.4 1084.3 1148.5 1151.3 1154.5 13232.3 13266.5 13364.1 13398.3 13406.2 4859.7 4962.3 5003.4 5042.5 5043.1 11103.7 11162.0 11178.8 11222.6 11228.2 5688.9 5691.5 5692.7 5716.7 5729.3 4436.9 4968.7 5064.5 5138.0 5145.9 4304.5 4344.1 4390.8 4422.8 4436.7 1346.4 1371.5 1384.7 1393.1 1409.1 952.8 1061.9 1066.2 1068.8 1082.7 6284.4 6432.8 6447.3 6448.0 6562.8 474.3 476.7 476.8 498.4 499.9 4437.6 4464.2 4476.4 4479.5 4574.7 11153.8 11322.2 11429.4 11475.1 11527.9 10958.9 11084.0 11181.7 11496.7 11503.3 8216.1 8224.7 8282.2 8320.2 8348.5 6178.6 6257.8 6272.8 6316.8 6359.9 10390.2 10516.9 10654.7 10697.6 10697.8 10547.6 10735.8 10786.3 10892.7 10924.7 7378.7 7831.8 7860.8 8042.4 8423.0 9266.6 9280.3 9298.7 9337.3 9345.0 8129.0 8351.6 8358.9 8438.3 8496.7 7873.1 7938.3 8111.6 8180.1 8298.1 7356.8 7376.0 7386.6 7444.2 7475.5 5352.4 5400.6 5404.3 5495.9 5588.9 5567.0 5664.5 5709.4 5745.6 5788.3 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | [#4] prototype.html Cycles:180 Average:4811.24 Median:5414.12 stddev:1395.81 (25.8%) stddev-sans-first:1358.69 20:29:02 INFO - PROCESS | 11973 | Values: 335.3 342.4 343.6 344.4 345.9 5526.8 5569.8 5639.7 5709.9 5809.9 5580.4 5607.4 5625.6 5637.3 5665.7 4436.2 4444.3 4466.3 4477.2 4491.8 4363.1 4394.2 4427.4 4451.8 4461.9 4337.0 4374.2 4390.4 4400.6 4425.9 4419.9 4419.9 4430.8 4437.3 4437.7 3711.6 3826.7 3838.1 3859.8 3875.4 5472.1 5489.2 5499.9 5502.5 5505.4 5017.0 5027.2 5056.7 5083.6 5107.4 5705.4 5948.6 5954.6 5977.7 5978.9 4266.4 4277.5 4282.7 4289.8 4291.5 5990.7 6113.6 6180.4 6230.1 6293.0 4311.7 4315.3 4321.9 4338.5 4354.0 4381.2 4383.9 4399.9 4405.1 4410.8 4770.3 5028.4 5045.6 5049.8 5079.9 5746.3 5809.3 5869.9 5870.8 5886.8 1480.6 1500.6 1505.7 1509.2 1523.2 946.9 950.1 967.0 967.9 976.0 5139.4 5153.4 5154.5 5161.3 5177.9 5422.9 5423.6 5446.7 5504.0 5519.7 4947.6 5070.0 5071.5 5132.6 5251.6 2868.7 2881.2 2972.9 2973.5 2979.8 5546.8 5574.2 5604.8 5611.3 5628.5 5347.8 5550.5 5579.4 5582.5 5595.6 5627.3 5692.3 5699.6 5706.8 5756.6 5094.3 5317.2 5327.9 5409.3 5455.6 5346.8 5350.5 5351.1 5368.9 5370.7 5598.5 5604.7 5610.5 5648.6 5671.5 3691.8 3880.6 3925.2 3939.6 4008.5 5409.4 5418.9 5505.7 5963.3 6223.3 5972.8 5998.3 6029.0 6031.9 6060.0 5960.4 6003.8 6025.5 6035.4 6057.4 5630.6 5821.5 5871.4 5904.9 5946.5 5965.1 6024.0 6038.8 6040.9 6045.4 5617.9 5886.6 5944.0 5950.9 5978.1 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - PROCESS | 11973 | [#5] yui.html Cycles:180 Average:21189.41 Median:4653.18 stddev:29583.56 (635.8%) stddev-sans-first:29626.61 20:29:02 INFO - PROCESS | 11973 | Values: 717.2 738.2 800.3 819.4 887.6 15934.3 17010.4 17162.8 17246.1 17248.8 14700.0 15124.9 15229.2 15269.2 15309.3 706.1 859.0 859.8 882.4 883.9 877.0 877.1 880.9 882.1 882.1 926.5 927.9 928.4 929.1 930.3 918.2 925.2 925.3 926.1 926.8 670.1 672.6 676.2 678.6 679.9 16022.6 16095.0 16130.3 16148.8 16243.6 15035.1 15399.4 15451.5 15840.1 16179.6 12506.9 12639.2 12686.8 12867.0 12885.1 4065.4 4103.2 4129.3 4132.9 4302.8 81067.6 81761.0 82924.8 83208.0 84389.0 12084.0 12260.9 12396.8 12492.3 12493.8 23199.4 23325.9 23327.5 23383.3 23406.3 9054.3 9121.7 9244.4 9284.0 9294.8 5100.9 5254.9 5279.7 5386.9 5480.3 3746.1 3838.8 3842.5 3880.9 3895.7 573.3 625.2 641.8 642.2 647.8 812.1 813.3 816.8 824.4 829.5 10638.9 10833.1 11034.3 11106.8 11149.3 842.5 849.1 850.8 865.8 870.9 5003.6 5152.3 5177.3 5213.8 5224.3 73717.3 89960.6 113325.0 123103.0 123427.4 63733.7 92091.5 99198.5 100053.0 101353.0 86942.0 87322.0 87750.6 88230.6 88238.4 9604.0 9835.3 9946.8 9985.3 10096.4 54850.5 55137.0 55280.0 56266.7 56417.0 77955.0 80639.2 81363.6 81441.0 81606.0 11612.0 11839.8 11842.5 12072.8 12999.9 14409.6 14503.4 14730.8 14837.1 15053.4 12839.4 13128.2 13242.3 13404.2 13832.6 12508.7 12513.9 12651.4 12663.1 12990.5 13564.0 13810.1 13904.7 14009.5 15004.2 12289.5 12467.6 12643.6 12807.1 13205.1 12528.6 12869.9 12888.5 12892.5 12903.7 20:29:02 INFO - PROCESS | 11973 | -------- Summary: end -------- 20:29:02 INFO - PROCESS | 11973 | 20:29:02 INFO - TEST-INFO | 11973: exit 0 20:29:02 INFO - TEST-OK | dromaeo_css | took 1109154ms 20:29:02 INFO - TEST-START | kraken 20:29:02 INFO - operating with platform_type : linux_ 20:29:02 INFO - Initialising browser for kraken test... 20:29:02 INFO - TEST-INFO | started process 12224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpri824K/profile http://localhost:44833/getInfo.html) 20:29:06 INFO - PROCESS | 12224 | __metrics Screen width/height:1600/1200 20:29:06 INFO - PROCESS | 12224 | colorDepth:24 20:29:06 INFO - PROCESS | 12224 | Browser inner width/height: 1024/697 20:29:06 INFO - PROCESS | 12224 | __metrics 20:29:07 ERROR - PROCESS | 12224 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 20:29:07 INFO - TEST-INFO | 12224: exit 0 20:29:07 INFO - Browser initialized. 20:29:07 INFO - Running cycle 1/1 for kraken test... 20:29:07 INFO - TEST-INFO | started process 12351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpri824K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:19 INFO - PROCESS | 12351 | RSS: Main: 156073984 20:29:19 INFO - PROCESS | 12351 | 20:29:22 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44833/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:23 INFO - PROCESS | 12351 | RSS: Main: 160972800 20:29:23 INFO - PROCESS | 12351 | 20:29:25 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44833/tests/kraken/driver.html?testName=audio-dft) 20:29:26 INFO - PROCESS | 12351 | RSS: Main: 160722944 20:29:26 INFO - PROCESS | 12351 | 20:29:29 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44833/tests/kraken/driver.html?testName=audio-fft) 20:29:29 INFO - PROCESS | 12351 | RSS: Main: 161357824 20:29:29 INFO - PROCESS | 12351 | 20:29:32 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44833/tests/kraken/driver.html?testName=audio-oscillator) 20:29:32 INFO - PROCESS | 12351 | RSS: Main: 160952320 20:29:32 INFO - PROCESS | 12351 | 20:29:34 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:35 INFO - PROCESS | 12351 | RSS: Main: 160780288 20:29:35 INFO - PROCESS | 12351 | 20:29:38 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44833/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:39 INFO - PROCESS | 12351 | RSS: Main: 160509952 20:29:39 INFO - PROCESS | 12351 | 20:29:42 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44833/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:43 INFO - PROCESS | 12351 | RSS: Main: 161050624 20:29:43 INFO - PROCESS | 12351 | 20:29:46 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44833/tests/kraken/driver.html?testName=json-parse-financial) 20:29:46 INFO - PROCESS | 12351 | RSS: Main: 160112640 20:29:46 INFO - PROCESS | 12351 | 20:29:48 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:48 INFO - PROCESS | 12351 | RSS: Main: 160190464 20:29:48 INFO - PROCESS | 12351 | 20:29:50 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:51 INFO - PROCESS | 12351 | RSS: Main: 160780288 20:29:51 INFO - PROCESS | 12351 | 20:29:53 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:53 INFO - PROCESS | 12351 | RSS: Main: 161185792 20:29:53 INFO - PROCESS | 12351 | 20:29:56 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:57 INFO - PROCESS | 12351 | RSS: Main: 161484800 20:29:57 INFO - PROCESS | 12351 | 20:29:59 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:30:00 INFO - PROCESS | 12351 | RSS: Main: 161275904 20:30:00 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | Cycle 1(1): loaded http://localhost:44833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44833/tests/kraken/driver.html?testName=ai-astar) 20:30:02 INFO - PROCESS | 12351 | RSS: Main: 161857536 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | __start_tp_report 20:30:02 INFO - PROCESS | 12351 | _x_x_mozilla_page_load 20:30:02 INFO - PROCESS | 12351 | _x_x_mozilla_page_load_details 20:30:02 INFO - PROCESS | 12351 | |i|pagename|runs| 20:30:02 INFO - PROCESS | 12351 | |0;ai-astar;118;106;112;111;111;112;113;113;112;112 20:30:02 INFO - PROCESS | 12351 | |1;audio-beat-detection;156;127;166;181;126;167;163;127;172;126 20:30:02 INFO - PROCESS | 12351 | |2;audio-dft;167;163;164;162;164;163;164;163;164;164 20:30:02 INFO - PROCESS | 12351 | |3;audio-fft;77;76;77;171;76;75;75;77;173;76 20:30:02 INFO - PROCESS | 12351 | |4;audio-oscillator;86;85;140;86;86;86;134;86;88;143 20:30:02 INFO - PROCESS | 12351 | |5;imaging-gaussian-blur;118;119;121;124;120;118;117;118;121;123 20:30:02 INFO - PROCESS | 12351 | |6;imaging-darkroom;147;148;147;149;148;147;148;148;149;148 20:30:02 INFO - PROCESS | 12351 | |7;imaging-desaturate;96;95;97;96;96;96;95;96;96;95 20:30:02 INFO - PROCESS | 12351 | |8;json-parse-financial;51;51;53;56;54;53;53;53;52;60 20:30:02 INFO - PROCESS | 12351 | |9;json-stringify-tinderbox;60;61;61;59;60;60;59;59;59;60 20:30:02 INFO - PROCESS | 12351 | |10;stanford-crypto-aes;78;77;79;78;79;80;81;77;109;85 20:30:02 INFO - PROCESS | 12351 | |11;stanford-crypto-ccm;121;118;134;127;122;133;123;120;127;140 20:30:02 INFO - PROCESS | 12351 | |12;stanford-crypto-pbkdf2;157;159;156;156;157;156;156;155;155;155 20:30:02 INFO - PROCESS | 12351 | |13;stanford-crypto-sha256-iterative;62;62;61;62;61;62;63;62;61;62 20:30:02 INFO - PROCESS | 12351 | __end_tp_report 20:30:02 INFO - PROCESS | 12351 | __start_cc_report 20:30:02 INFO - PROCESS | 12351 | _x_x_mozilla_cycle_collect,877 20:30:02 INFO - PROCESS | 12351 | __end_cc_report 20:30:02 INFO - PROCESS | 12351 | __startTimestamp1467948602290__endTimestamp 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | ------- Summary: start ------- 20:30:02 INFO - PROCESS | 12351 | Number of tests: 14 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:2.91 (2.6%) stddev-sans-first:2.12 20:30:02 INFO - PROCESS | 12351 | Values: 118.0 106.0 112.0 111.0 111.0 112.0 113.0 113.0 112.0 112.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:164.50 stddev:22.09 (13.4%) stddev-sans-first:23.36 20:30:02 INFO - PROCESS | 12351 | Values: 156.0 127.0 166.0 181.0 126.0 167.0 163.0 127.0 172.0 126.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.32 (0.8%) stddev-sans-first:0.73 20:30:02 INFO - PROCESS | 12351 | Values: 167.0 163.0 164.0 162.0 164.0 163.0 164.0 163.0 164.0 164.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:40.43 (53.2%) stddev-sans-first:42.34 20:30:02 INFO - PROCESS | 12351 | Values: 77.0 76.0 77.0 171.0 76.0 75.0 75.0 77.0 173.0 76.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:86.00 stddev:25.63 (29.8%) stddev-sans-first:26.53 20:30:02 INFO - PROCESS | 12351 | Values: 86.0 85.0 140.0 86.0 86.0 86.0 134.0 86.0 88.0 143.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#5] imaging-gaussian-blur Cycles:10 Average:119.90 Median:120.50 stddev:2.33 (1.9%) stddev-sans-first:2.37 20:30:02 INFO - PROCESS | 12351 | Values: 118.0 119.0 121.0 124.0 120.0 118.0 117.0 118.0 121.0 123.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 20:30:02 INFO - PROCESS | 12351 | Values: 147.0 148.0 147.0 149.0 148.0 147.0 148.0 148.0 149.0 148.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:30:02 INFO - PROCESS | 12351 | Values: 96.0 95.0 97.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:2.67 (5.0%) stddev-sans-first:2.67 20:30:02 INFO - PROCESS | 12351 | Values: 51.0 51.0 53.0 56.0 54.0 53.0 53.0 53.0 52.0 60.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 20:30:02 INFO - PROCESS | 12351 | Values: 60.0 61.0 61.0 59.0 60.0 60.0 59.0 59.0 59.0 60.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:79.00 stddev:9.67 (12.2%) stddev-sans-first:10.13 20:30:02 INFO - PROCESS | 12351 | Values: 78.0 77.0 79.0 78.0 79.0 80.0 81.0 77.0 109.0 85.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.00 stddev:7.14 (5.6%) stddev-sans-first:7.29 20:30:02 INFO - PROCESS | 12351 | Values: 121.0 118.0 134.0 127.0 122.0 133.0 123.0 120.0 127.0 140.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:156.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 20:30:02 INFO - PROCESS | 12351 | Values: 157.0 159.0 156.0 156.0 157.0 156.0 156.0 155.0 155.0 155.0 20:30:02 INFO - PROCESS | 12351 | 20:30:02 INFO - PROCESS | 12351 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 20:30:02 INFO - PROCESS | 12351 | Values: 62.0 62.0 61.0 62.0 61.0 62.0 63.0 62.0 61.0 62.0 20:30:02 INFO - PROCESS | 12351 | -------- Summary: end -------- 20:30:02 INFO - PROCESS | 12351 | 20:30:03 INFO - TEST-INFO | 12351: exit 0 20:30:03 INFO - TEST-OK | kraken | took 60480ms 20:30:03 INFO - SUITE-END | took 1169s 20:30:03 INFO - Completed test suite (00:19:29) 20:30:03 INFO - javascript benchmark 20:30:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7624.163030591529, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.6826351496607, 3381.289929114885, 3389.1188291044323, 3409.267007593365, 3417.897463076107, 5531.695756733378, 5533.474319939604, 5585.078462053756, 5644.238027866247, 5647.491725744682, 5652.63257888237, 5689.203511508392, 5700.201971723952, 5718.199452076702, 5739.397363276858, 5145.845624631267, 5196.934628401187, 5247.055530004598, 5247.239150323201, 5270.341207349082, 5042.092423363793, 5062.746862656871, 5145.6398052136365, 5301.469853014706, 5306.761195746181, 5099.260607211952, 5152.92270615941, 5162.690238585678, 5193.948060519403, 5197.0905091609, 5159.638825282232, 5167.586593072583, 5194.584433245332, 5247.632665713401, 5286.841394758163, 4961.5038496150455, 5122.231665250242, 5200.0, 5237.607179461517, 5254.763535640867, 5456.863578410532, 5464.398916119224, 5525.281713377275, 5536.7231638418325, 5584.0507113790345, 5964.880702385928, 6006.399360064002, 6011.6393016418715, 6087.1173679816175, 6095.08573713942, 5879.617824841414, 6077.574569780118, 6145.047517634774, 6150.04674275488, 6158.230221222348, 5743.339515955677, 5773.9422605773825, 5804.361520232771, 5806.680632565207, 5811.215485909391, 6235.158253635792, 6303.180586523723, 6311.800757855993, 6325.399087086719, 6338.397852204033, 5908.0, 5936.7922122725495, 5981.820545383558, 6089.8477538061015, 6094.786682466181, 6160.075988601656, 6172.969135154385, 6180.907286390708, 6184.350643182401, 6188.504919606421, 6047.365026672224, 6100.48145907594, 6125.9693701531205, 6132.356102609251, 6133.355997620186, 5894.204282421904, 5901.911471327933, 5945.375735547792, 5949.375315591887, 6074.51403887688, 4609.677322587387, 4634.884127896829, 4656.743879086615, 4664.766761661971, 4691.882702932454, 4163.0, 4171.124063946605, 4174.686898482626, 4199.622034016953, 4199.9370009449885, 5602.887942241132, 5734.340550836707, 5827.3007239131575, 5849.151872978395, 5874.853128671817, 6038.879222415527, 6118.162361256266, 6128.717018009172, 6130.321737090849, 6141.570090093651, 5691.430856914359, 5854.736536855852, 5856.531477481792, 5859.062549991981, 5874.823755287262, 5170.250313704491, 5201.817936372209, 5207.270982062514, 5207.869803254949, 5214.869628259324, 6301.4328710416285, 6320.178376811077, 6322.0, 6341.239051313872, 6446.258680251737, 5945.583809133319, 6094.969525152346, 6125.877482450326, 6171.259448866164, 6178.41305076017, 6353.174087368612, 6450.451711604378, 6451.677416129269, 6473.805785826433, 6473.967630161819, 5982.162497250475, 5988.8802223956145, 6016.518678505621, 6025.096235564701, 6042.637441753509, 5988.341282459013, 6028.849278768066, 6056.424639659225, 6162.445379915829, 6164.630122192682, 5946.048632218824, 5981.162637230704, 5992.730327135377, 5997.940020599913, 6005.759769609167, 5910.438508341701, 5923.4076592340425, 5923.911141332969, 5990.760369585168, 6015.6691381974415, 5654.943450565442, 5824.912626310524, 5872.530197584098, 5877.353491115889, 5929.347771745019, 6021.337652858095, 6045.395460454095, 6095.542834287535, 6099.237595300588, 6114.510839132769, 5885.735141918538, 5924.052151655715, 5927.347991720821, 5989.8203053908455, 5989.8203053908455], "value": 5626.420285119626, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.7145370222294, 615.8706671598964, 650.6616559389117, 660.6234446365571, 674.9628770417628, 44856.77571612142, 46092.76953615227, 46123.76938115309, 46208.76895615521, 49879.0, 47307.0, 47805.52194478054, 48021.7598912005, 48110.27834582475, 48200.27699584509, 8886.555672216396, 8999.100089990981, 9001.77495562613, 9002.954985225064, 9051.864222036675, 8956.462612243286, 8960.23837973773, 9011.684591039315, 9026.954865225698, 9042.683506077288, 9044.819103617923, 9046.411983221102, 9113.772155696095, 9117.179453849152, 9118.17936385725, 8928.330375221853, 9002.234810041155, 9018.86471702925, 9021.639134434614, 9050.773730656787, 8880.067592902782, 8892.510911899843, 8908.06465321145, 8911.287097032287, 8949.59726812295, 43918.56081439208, 44077.55922440767, 44125.117497650186, 44195.0, 44416.667499975054, 3637.236180402119, 3735.4957080794015, 3773.2642134783728, 3891.8248678809523, 4196.685248606367, 32957.835210823796, 33144.50283245753, 33537.32925341504, 33705.49441758376, 33912.49131263008, 4214.966256450979, 4260.424842646234, 4297.97851010746, 4322.7190232634775, 4397.406350142722, 265814.0, 266160.0, 266180.0, 266195.0, 266368.0, 33673.66326336705, 60826.0, 61433.69283153645, 61529.69235153795, 61639.69180154071, 40857.182856342704, 41119.0, 41228.38157427641, 41243.1751364971, 41419.0, 16419.58951026234, 16867.072311022766, 16977.236024378934, 16980.660386792442, 16993.0, 13945.58163255104, 13945.65135871591, 14050.508232211823, 14076.0, 14090.788638170436, 9156.0, 9185.081491850895, 9205.447673139633, 9269.72190834276, 9331.066893310615, 3478.1826270826336, 3538.097785064792, 3546.361654902091, 3550.396432606463, 3587.0, 1075.3010543147018, 1096.1121491591837, 1139.2879450343535, 1144.1133121830649, 1196.1387800783596, 33783.66216337854, 34047.659523404946, 34064.14839629029, 34276.31447371088, 34320.82839585786, 1128.9943550282196, 1163.6101905861462, 1175.5415387998687, 1221.3954092723982, 1253.0915086562352, 17795.110244487725, 17807.46577602674, 17865.910670446563, 17882.91058544725, 17934.923904565767, 557377.0, 861695.0, 863973.0, 954306.0, 961370.0, 61031.0, 61967.690161548904, 62026.689866550376, 62346.0, 62407.0, 1468.6768910839598, 1501.2868887278673, 1506.7965824613757, 1518.3395223077996, 1522.8173118183051, 30505.694943051174, 31191.0, 31817.0, 31884.840575796974, 32466.188345291557, 51270.0, 51968.220476693634, 52379.21431178611, 52407.73796130995, 52498.73750631375, 394877.0, 395410.0, 395991.0, 398063.0, 399908.0, 29285.70714292915, 29603.703962960095, 29724.554131688474, 29777.85111074431, 29807.55288670715, 46925.0, 47591.52408475871, 48066.5193348062, 48702.26946595875, 49146.75426622844, 40316.1936761269, 40816.59183408128, 41056.58943410528, 41094.38358424686, 41383.793081034404, 38856.61143388643, 40117.79941100276, 40294.19411611693, 40732.389014165405, 42880.0, 43682.34476482792, 43829.0, 43903.560964389944, 44466.55533444624, 44575.55424445714, 37681.43477847889, 38184.618153818104, 38203.80898095492, 38793.224135517696, 39012.60987390203, 29246.415071698022, 29859.0, 29926.0, 30034.699653004063, 30245.0], "value": 19809.674116722777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.4998926283091, 425.4745389444037, 431.80784550874876, 434.72612254279807, 444.69316171841444, 17737.467875963725, 18939.33712320069, 19559.706604400926, 19646.607067858633, 19927.302544410948, 18838.811611883877, 19161.42515724527, 19444.222231110773, 19831.0, 19922.90038549805, 5502.532284755801, 5684.289463817023, 5847.912281315784, 5851.912221316684, 5857.062869940811, 5567.749451274703, 5684.317881854163, 5709.74306156224, 5758.193852860602, 5765.394633563478, 5797.869415463986, 5798.449147331018, 5801.593888427812, 5807.796727114552, 5811.157382179582, 5659.886802263973, 5750.079987202049, 5766.769329226805, 6900.7929762107215, 7346.669399877019, 7126.0736104306625, 7153.642317884137, 7161.248068952789, 7177.174624918149, 7197.316254955771, 23508.294751157493, 24492.265232043068, 25162.24513264605, 26293.34266643349, 26489.602655960178, 2414.360194548446, 2517.848929064262, 2608.4652646207483, 2672.4521473097966, 2742.478929003503, 15900.840991590052, 16739.330426782915, 16859.578510537212, 16879.66240675192, 16926.23831927566, 2171.2400659769114, 2184.5740080684272, 2195.560887822426, 2262.751097379287, 2306.4810417656063, 102537.0, 106083.46958265237, 110044.0, 110266.0, 110754.0, 18082.63834723298, 18664.813351866578, 18829.90585047066, 18912.148953297135, 18922.716159257623, 34356.14109647279, 34506.309873802384, 34737.82631086828, 34875.12812179665, 35002.474962875574, 10235.795284094276, 10694.786104277871, 10740.516676749565, 10814.56741730322, 10895.673129806119, 8882.06738292483, 8882.111788821196, 8934.24058954983, 9004.549772511347, 9072.004159085123, 9311.348205625542, 9346.859797103049, 9368.625254989724, 9412.0, 9450.669226577036, 3634.8727794527063, 3700.1119731264303, 3712.5916149223563, 3831.444440556104, 3917.4123881418013, 949.7103383468109, 1001.9048190421898, 1038.314712289885, 1092.792369449802, 1120.7310245541012, 17310.307587696352, 18589.44231673052, 18755.531111722317, 19334.516637084187, 19386.418407447516, 1032.2670903658486, 1035.9689209323733, 1055.2507719519074, 1104.5968221599057, 1105.530149686396, 10572.735681607868, 10908.61819836302, 10987.0, 11003.61487347939, 11012.39431831257, 536571.0, 543464.0, 545980.0, 560306.0, 575373.0, 95756.52121739347, 96670.0, 97944.0, 98028.0, 100683.49658251661, 1048.895110488945, 1083.4799296337644, 1132.7168207948014, 1159.756451145269, 1159.8492196014465, 17064.0, 17365.73951390705, 17384.304627814745, 17484.47546573605, 17612.91193544024, 41643.0, 41681.58318416898, 42361.57638423699, 42576.08407621727, 43022.784886075366, 58259.4174058254, 59684.403155967884, 60312.0, 60375.698121509115, 61345.38654613397, 5602.551795856403, 7606.847863042819, 7830.843383132419, 8089.312408445113, 9033.503157326148, 12085.577004804789, 13601.523946661819, 13637.863621364057, 13664.726705465637, 13671.38478768438, 11486.483108259981, 11656.88343116558, 11847.466863990969, 11868.10989175798, 12024.218425802295, 7752.573608451589, 7902.762917112495, 11536.36549989725, 11583.942080289544, 11754.882451175721, 11983.880161198276, 12119.697007574881, 12132.454039568063, 12419.875801242233, 12423.937880310903, 8092.71675491355, 8160.795980100545, 8186.058603260702, 8189.181081891763, 8295.336373090018, 11629.59296424621, 12013.75972480528, 12107.878921210675, 12138.939305303416, 12184.268943863397], "value": 10550.53187591059, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.529223586806, 1577.5267419774068, 1746.799118101418, 1838.880472769269, 1860.2558976409434, 8176.345892328614, 8688.565571721405, 8846.071162527931, 9230.0, 9302.86045709314, 8800.77998050049, 8885.86671199931, 8965.28277737781, 9017.909820901788, 9129.452232866033, 2313.097891822191, 2336.894839732208, 2338.929832105031, 2340.3681006128336, 2344.7186337639505, 2238.1942500699734, 2255.1768604459335, 2272.284230467406, 2272.5114100468395, 2274.1585613323095, 2249.4488850231714, 2262.909483620653, 2270.977290227093, 2273.943151421211, 2285.1773361589812, 2322.500662357593, 2365.491419344849, 2376.714794224687, 2382.7855493005713, 2385.6540801583847, 2422.176460003607, 2425.333033415807, 2439.6462512935705, 2445.596476581362, 2460.052879641333, 8933.553322333857, 8984.775380615472, 8992.055834137453, 9012.909870901272, 9086.45481271126, 5385.138377859524, 5401.3248343957, 5478.643888147298, 5484.287042684466, 5577.163425486169, 3430.1081718753053, 3443.070370999841, 3516.525269088666, 3519.3137338219058, 3521.014116047485, 1065.4140222877386, 1084.3439718970067, 1148.4544841200448, 1151.2977083978767, 1154.4516354731436, 13232.27222502762, 13266.469341226339, 13364.06451548392, 13398.330083495885, 13406.195628262336, 4859.732714700725, 4962.255661650781, 5003.424606170337, 5042.546170844568, 5043.117454445457, 11103.666889993314, 11162.0, 11178.832317515244, 11222.607208747655, 11228.214025018333, 5688.943110568841, 5691.4877661010705, 5692.715364231772, 5716.657000579979, 5729.28383952006, 4436.911261774746, 4968.726720030433, 5064.46823083571, 5137.9743101285, 5145.871353216199, 4304.4834619845815, 4344.087741574242, 4390.846320378835, 4422.84520041797, 4436.733795972252, 1346.4479563378968, 1371.4582739817915, 1384.6746014686541, 1393.0596847128147, 1409.0911362171341, 952.7760976170595, 1061.946902654864, 1066.2056767707952, 1068.7755571330108, 1082.6968448834339, 6284.4344009039405, 6432.807015789534, 6447.323031081763, 6447.968325067966, 6562.835929101715, 474.3454033433839, 476.72111814588163, 476.77114984807486, 498.40938487891964, 499.93500844889934, 4437.5784300491405, 4464.2187617166865, 4476.395686582335, 4479.484859241229, 4574.725516469022, 11153.776924461465, 11322.150838686966, 11429.371384573928, 11475.139364547693, 11527.942360288313, 10958.945205273923, 11084.00243978046, 11181.664550063511, 11496.712582185344, 11503.309801411942, 8216.137305582948, 8224.671013159526, 8282.213189746964, 8320.209580089882, 8348.457350272212, 6178.567500274938, 6257.78097766576, 6272.780452684134, 6316.810495685137, 6359.904601431075, 10390.22073344487, 10516.894831051897, 10654.73363165927, 10697.572097116028, 10697.786044278915, 10547.630832920811, 10735.785284294114, 10786.298890572089, 10892.727681808019, 10924.726881828017, 7378.667959941708, 7831.765047048598, 7860.84278314442, 8042.437029407885, 8423.0, 9266.583003764712, 9280.303977201871, 9298.674546390845, 9337.253019758538, 9344.95327523358, 8128.9593552031865, 8351.624176911931, 8358.916410835815, 8438.324934005388, 8496.745097647081, 7873.0945941215205, 7938.3252423544645, 8111.634976426193, 8180.059293181361, 8298.128696487023, 7356.77929662111, 7375.963120184365, 7386.556806591621, 7444.218357072429, 7475.476716629783, 5352.437994010573, 5400.648957817729, 5404.297441332759, 5495.890082198413, 5588.944110558842, 5567.025770490229, 5664.461876121762, 5709.429057094258, 5745.626534275259, 5788.305403351625], "value": 4781.8828559648755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.284168300678, 342.3768740891577, 343.63402975830724, 344.39558574701425, 345.86684126611254, 5526.806561770339, 5569.805056823007, 5639.674676451041, 5709.942900570998, 5809.854753631156, 5580.441955804417, 5607.439256074391, 5625.606207565472, 5637.307563545884, 5665.660060396369, 4436.223660859353, 4444.33334999751, 4466.33005049242, 4477.171723231205, 4491.820327186909, 4363.127374525092, 4394.165108629366, 4427.358033085201, 4451.755153466558, 4461.888452788674, 4336.956630433702, 4374.234508960935, 4390.42924419825, 4400.6259467945265, 4425.933610995838, 4419.911601767946, 4419.922636360921, 4430.759387371541, 4437.290033594625, 4437.667174961858, 3711.6102809204913, 3826.7129965252716, 3838.098046958962, 3859.826307816155, 3875.360565506688, 5472.1244600864065, 5489.204065410533, 5499.945000549983, 5502.477264659851, 5505.366882808488, 5017.0, 5027.220780778948, 5056.6852618319135, 5083.61872859537, 5107.387113546361, 5705.372409035002, 5948.643081415085, 5954.55340849438, 5977.701114944235, 5978.910316345258, 4266.360045993126, 4277.508086570022, 4282.721623094489, 4289.849855255051, 4291.527931927485, 5990.700464976778, 6113.57204995655, 6180.443760061571, 6230.065490176465, 6293.024581189923, 4311.676624253194, 4315.331123675835, 4321.891952701208, 4338.47938247406, 4353.956460435418, 4381.2332841753205, 4383.890402739957, 4399.934000989988, 4405.140997505456, 4410.757408342508, 4770.332153498513, 5028.396592408862, 5045.596352291808, 5049.84850454487, 5079.923801142986, 5746.2529871116485, 5809.331926828384, 5869.941300586939, 5870.7945221917025, 5886.823395298148, 1480.6298425393652, 1500.6023403798001, 1505.6913332766756, 1509.2001239343165, 1523.2459932333566, 946.9053094690476, 950.1258841865363, 966.9661561845302, 967.8917639303099, 975.9853602195973, 5139.357580302462, 5153.3558305211845, 5154.458781827854, 5161.329027226437, 5177.948220517822, 5422.891542169214, 5423.647462914898, 5446.700431476307, 5503.981763373788, 5519.69641669704, 4947.6289278304275, 5069.997351046316, 5071.54356107952, 5132.615053870974, 5251.55582214894, 2868.6557613086147, 2881.1644623059497, 2972.9256768580526, 2973.52423612221, 2979.791414600957, 5546.7781288748, 5574.219609254707, 5604.766951270714, 5611.3266408031295, 5628.493435590734, 5347.834127178499, 5550.528205102531, 5579.442055794388, 5582.525485333711, 5595.63628364155, 5627.296587926509, 5692.324607434416, 5699.572532060112, 5706.800261990894, 5756.5682573807135, 5094.312267843942, 5317.229001794795, 5327.946720532745, 5409.295352323838, 5455.563554915677, 5346.812861549827, 5350.491703288181, 5351.117065684274, 5368.865778355573, 5370.711029353005, 5598.544378461548, 5604.719764011865, 5610.4670056344585, 5648.63283886546, 5671.461211184931, 3691.778493290411, 3880.631340022693, 3925.2149570085526, 3939.6060393960374, 4008.4588580542422, 5409.377921538916, 5418.864528386822, 5505.724713764376, 5963.344032156546, 6223.284322302812, 5972.761089556369, 5998.310194327708, 6028.969855150696, 6031.879362412639, 6060.0, 5960.433758792908, 6003.8386180975685, 6025.517958563392, 6035.366286540026, 6057.363976782374, 5630.605857590093, 5821.534277257894, 5871.412858714094, 5904.852378690567, 5946.494547963299, 5965.1209868891165, 6023.969880150571, 6038.849028774316, 6040.909386359296, 6045.425684559959, 5617.943820561742, 5886.558508111823, 5943.970280148572, 5950.851228719317, 5978.103284507359], "value": 4365.293806133991, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.1716667249323, 738.2174894611716, 800.279748226596, 819.414118904983, 887.5828360670484, 15934.282957266922, 17010.40463583775, 17162.828371716278, 17246.137693115357, 17248.827511724863, 14700.0, 15124.924375378136, 15229.238538073107, 15269.160196189205, 15309.311081001353, 706.0538877903608, 858.9656413743443, 859.8495263328924, 882.3779235638891, 883.8762573239752, 876.9956150219272, 877.1491653096487, 880.9339299552527, 882.1046637662778, 882.1178821178821, 926.4811705444939, 927.9211267042309, 928.4243768863314, 929.0755698080419, 930.2790337488433, 918.1782304837134, 925.1812146250583, 925.259792166271, 926.1063074133493, 926.8424367857447, 670.058567712365, 672.6300534705892, 676.1818199978032, 678.6097993653619, 679.9354061364163, 16022.5994350141, 16095.0, 16130.274137663833, 16148.75776863348, 16243.593910152222, 15035.097894126387, 15399.384024639001, 15451.459198928096, 15840.128792916385, 16179.595510112224, 12506.874931250662, 12639.241645501208, 12686.80969785454, 12867.034972377109, 12885.098043136984, 4065.410515475269, 4103.199876024147, 4129.29801933672, 4132.855350062733, 4302.763348015857, 81067.59466202631, 81761.0, 82924.75612865812, 83208.0, 84389.0, 12084.0, 12260.938695306466, 12396.75206495865, 12492.312922789151, 12493.750124997448, 23199.420014499774, 23325.88337058304, 23327.53344933092, 23383.298501044996, 23406.297811065695, 9054.320925930582, 9121.726348209564, 9244.445333280024, 9284.0, 9294.767630809149, 5100.897982040413, 5254.868628284324, 5279.683219006872, 5386.865328366822, 5480.287562616834, 3746.100935775394, 3838.788866612363, 3842.51968503937, 3880.902977425587, 3895.7272990890365, 573.2576313673719, 625.2497003595703, 641.7978336823885, 642.1651852591706, 647.8121344810047, 812.1026265976011, 813.3046245460165, 816.7631386897851, 824.4476200945381, 829.5478963964654, 10638.893611063944, 10833.133349332034, 11034.337939723642, 11106.833397499044, 11149.331040137618, 842.5281842168405, 849.1338834388889, 850.8085680721788, 865.7835541114721, 870.8867847179953, 5003.5997120230295, 5152.3044389007755, 5177.326947496801, 5213.843584692465, 5224.320838290998, 73717.2628273721, 89960.5501972486, 113325.0, 123103.0, 123427.3828630851, 63733.68133159305, 92091.53954230186, 99198.50400748095, 100053.0, 101353.0, 86942.0, 87322.0, 87750.56124719336, 88230.55884720535, 88238.35284941334, 9604.0, 9835.311528192959, 9946.751331216778, 9985.251106166921, 10096.394216347042, 54850.45149548613, 55137.0, 55280.0, 56266.71866640641, 56417.0, 77955.0, 80639.19360806317, 81363.59318203371, 81441.0, 81606.0, 11612.0, 11839.82240266414, 11842.46708898119, 12072.75854482888, 12999.935000324938, 14409.639759006108, 14503.419863205776, 14730.77903831422, 14837.10977341363, 15053.397864085315, 12839.358032098544, 13128.212307261594, 13242.271675057964, 13404.195748255135, 13832.585022449342, 12508.749825003268, 12513.874861251272, 12651.367431628198, 12663.113582049167, 12990.480380784662, 13564.0, 13810.10234334765, 13904.652383690489, 14009.509667161601, 15004.174770387297, 12289.508419663114, 12467.563635272722, 12643.620691379274, 12807.089798490673, 13205.141665792076, 12528.561500347445, 12869.871301286867, 12888.548900788428, 12892.548760793326, 12903.677408064874], "value": 8000.436825405292, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 106.0, 112.0, 111.0, 111.0, 112.0, 113.0, 113.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 166.0, 181.0, 126.0, 167.0, 163.0, 127.0, 172.0, 126.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 164.0, 162.0, 164.0, 163.0, 164.0, 163.0, 164.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 171.0, 76.0, 75.0, 75.0, 77.0, 173.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 140.0, 86.0, 86.0, 86.0, 134.0, 86.0, 88.0, 143.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 121.0, 124.0, 120.0, 118.0, 117.0, 118.0, 121.0, 123.0], "value": 119.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 148.0, 147.0, 148.0, 148.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 56.0, 54.0, 53.0, 53.0, 53.0, 52.0, 60.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 79.0, 78.0, 79.0, 80.0, 81.0, 77.0, 109.0, 85.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 134.0, 127.0, 122.0, 133.0, 123.0, 120.0, 127.0, 140.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 156.0, 156.0, 157.0, 156.0, 156.0, 155.0, 155.0, 155.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 63.0, 62.0, 61.0, 62.0], "value": 61.8, "unit": "score"}]}]} 20:30:03 INFO - Return code: 0 20:30:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:30:03 ERROR - # TBPL SUCCESS # 20:30:03 INFO - Running post-action listener: _resource_record_post_action 20:30:03 INFO - ##### 20:30:03 INFO - ##### Finished run-tests step (success) 20:30:03 INFO - ##### 20:30:03 INFO - Running post-run listener: _resource_record_post_run 20:30:03 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 290816; Write bytes: 514756608; Read time: 36; Write time: 544844 20:30:03 INFO - TinderboxPrint: CPU usage
13.5% 20:30:03 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 36 20:30:03 INFO - TinderboxPrint: I/O write bytes / time
514,756,608 / 544,844 20:30:03 INFO - TinderboxPrint: CPU idle
8,190.0 (86.5%) 20:30:03 INFO - TinderboxPrint: CPU user
1,220.7 (12.9%) 20:30:03 INFO - TinderboxPrint: Swap in / out
0 / 0 20:30:03 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259813376; Read time: 0; Write time: 373948 20:30:03 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254357504; Read time: 28; Write time: 170868 20:30:04 INFO - Running post-run listener: _upload_blobber_files 20:30:04 INFO - Blob upload gear active. 20:30:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:30:04 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 20:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:30:04 INFO - (blobuploader) - INFO - Open directory for files ... 20:30:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:30:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:05 INFO - (blobuploader) - INFO - Done attempting. 20:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:09 INFO - (blobuploader) - INFO - Done attempting. 20:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:30:10 INFO - (blobuploader) - INFO - Done attempting. 20:30:10 INFO - (blobuploader) - INFO - Iteration through files over. 20:30:10 INFO - Return code: 0 20:30:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:30:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:30:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16e50e5ffeacc32afc8086b554ce8e399a34a1819f9e8b216cce2c8976fc9703cc15fd49818ad5e249cdf7a9cdff6b16b6178f7e671c80880a2fb5b03804c4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec872346d195ffab128133d24d19257dcce3cc0d3bb34e80adff2e6879aeaa1576b8944f794948e2f9a027c60914c1228697f420f1e091b79abc1b7c595ba93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38a167738f314489f94501d2a48307c964af53841fb96e2bba94eb4f834fa8cd0045721f40b8e014c742a9dd58ae3aa8cb4c40b9c4cf6fcc95826a05c96e558a"} 20:30:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:30:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:30:10 INFO - Contents: 20:30:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16e50e5ffeacc32afc8086b554ce8e399a34a1819f9e8b216cce2c8976fc9703cc15fd49818ad5e249cdf7a9cdff6b16b6178f7e671c80880a2fb5b03804c4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec872346d195ffab128133d24d19257dcce3cc0d3bb34e80adff2e6879aeaa1576b8944f794948e2f9a027c60914c1228697f420f1e091b79abc1b7c595ba93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38a167738f314489f94501d2a48307c964af53841fb96e2bba94eb4f834fa8cd0045721f40b8e014c742a9dd58ae3aa8cb4c40b9c4cf6fcc95826a05c96e558a"} 20:30:10 INFO - Running post-run listener: copy_logs_to_upload_dir 20:30:10 INFO - Copying logs to upload dir... 20:30:10 INFO - mkdir: /builds/slave/test/build/upload/logs 20:30:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.516114 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-07 20:30:10.256124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:30:10.259551) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16e50e5ffeacc32afc8086b554ce8e399a34a1819f9e8b216cce2c8976fc9703cc15fd49818ad5e249cdf7a9cdff6b16b6178f7e671c80880a2fb5b03804c4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec872346d195ffab128133d24d19257dcce3cc0d3bb34e80adff2e6879aeaa1576b8944f794948e2f9a027c60914c1228697f420f1e091b79abc1b7c595ba93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38a167738f314489f94501d2a48307c964af53841fb96e2bba94eb4f834fa8cd0045721f40b8e014c742a9dd58ae3aa8cb4c40b9c4cf6fcc95826a05c96e558a"} build_url:https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/fM4_ReWnTFW8z7HKThHUMQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16e50e5ffeacc32afc8086b554ce8e399a34a1819f9e8b216cce2c8976fc9703cc15fd49818ad5e249cdf7a9cdff6b16b6178f7e671c80880a2fb5b03804c4bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec872346d195ffab128133d24d19257dcce3cc0d3bb34e80adff2e6879aeaa1576b8944f794948e2f9a027c60914c1228697f420f1e091b79abc1b7c595ba93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38a167738f314489f94501d2a48307c964af53841fb96e2bba94eb4f834fa8cd0045721f40b8e014c742a9dd58ae3aa8cb4c40b9c4cf6fcc95826a05c96e558a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:30:10.285576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:30:10.285981) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1467947379.213233-1705335864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:30:10.368089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:30:10.368406) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:30:10.368722) ========= ========= Total master_lag: 0.17 =========