builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1465562486.22 results: success (0) buildid: 20160610030239 builduid: 24c9737725dd49398922c66457171ff8 revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.219305) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.219879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.220421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.235970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.236298) ========= 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=eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 05:41:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.8M=0s 2016-06-10 05:41:26 (49.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.323121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.323923) ========= 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=eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022208 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.376687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:26.377127) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --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=eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 05:41:26,571 truncating revision to first 12 chars 2016-06-10 05:41:26,571 Setting DEBUG logging. 2016-06-10 05:41:26,571 attempt 1/10 2016-06-10 05:41:26,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ccccf8e5036?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 05:41:26,865 unpacking tar archive at: mozilla-central-3ccccf8e5036/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:27.005431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:27.005775) ========= script_repo_revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:27.006290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:27.006652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:27.019192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-10 05:41:27.019532) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:27 INFO - MultiFileLogger online at 20160610 05:41:27 in /builds/slave/test 05:41:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:41:27 INFO - {'append_to_log': False, 05:41:27 INFO - 'base_work_dir': '/builds/slave/test', 05:41:27 INFO - 'blob_upload_branch': 'Firefox', 05:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:41:27 INFO - 'branch': 'Firefox', 05:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:27 INFO - 'config_files': ('talos/linux_config.py',), 05:41:27 INFO - 'default_actions': ('clobber', 05:41:27 INFO - 'read-buildbot-config', 05:41:27 INFO - 'download-and-extract', 05:41:27 INFO - 'populate-webroot', 05:41:27 INFO - 'create-virtualenv', 05:41:27 INFO - 'install', 05:41:27 INFO - 'run-tests'), 05:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:27 INFO - 'download_minidump_stackwalk': True, 05:41:27 INFO - 'download_symbols': 'ondemand', 05:41:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:27 INFO - 'installer_path': 'installer.exe', 05:41:27 INFO - 'log_level': 'info', 05:41:27 INFO - 'log_name': 'talos', 05:41:27 INFO - 'log_to_console': True, 05:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:27 INFO - 'opt_config_files': (), 05:41:27 INFO - 'pip_index': False, 05:41:27 INFO - 'sps_profile': False, 05:41:27 INFO - 'sps_profile_interval': 0, 05:41:27 INFO - 'suite': 'dromaeojs', 05:41:27 INFO - 'system_bits': '32', 05:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:27 INFO - 'title': 'talos-linux64-ix-010', 05:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:27 INFO - 'use_talos_json': True, 05:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:27 INFO - 'work_dir': 'build'} 05:41:27 INFO - ##### 05:41:27 INFO - ##### Running clobber step. 05:41:27 INFO - ##### 05:41:27 INFO - Running pre-action listener: _resource_record_pre_action 05:41:27 INFO - Running main action method: clobber 05:41:27 INFO - rmtree: /builds/slave/test/build 05:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:41:27 INFO - Running post-action listener: _resource_record_post_action 05:41:27 INFO - ##### 05:41:27 INFO - ##### Finished clobber step (success) 05:41:27 INFO - ##### 05:41:27 INFO - ##### 05:41:27 INFO - ##### Running read-buildbot-config step. 05:41:27 INFO - ##### 05:41:27 INFO - Running pre-action listener: _resource_record_pre_action 05:41:27 INFO - Running main action method: read_buildbot_config 05:41:27 INFO - Using buildbot properties: 05:41:27 INFO - { 05:41:27 INFO - "project": "", 05:41:27 INFO - "product": "firefox", 05:41:27 INFO - "script_repo_revision": "production", 05:41:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:41:27 INFO - "repository": "", 05:41:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:41:27 INFO - "buildid": "20160610030239", 05:41:27 INFO - "stage_platform": "linux64-pgo", 05:41:27 INFO - "basedir": "/builds/slave/test", 05:41:27 INFO - "nightly_build": "True", 05:41:27 INFO - "buildnumber": 335, 05:41:27 INFO - "slavename": "talos-linux64-ix-010", 05:41:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:41:27 INFO - "platform": "ubuntu64_hw", 05:41:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:41:27 INFO - "branch": "mozilla-central", 05:41:27 INFO - "repo_path": "mozilla-central", 05:41:27 INFO - "revision": "3ccccf8e5036179a3178437cabc154b5e04b333d", 05:41:27 INFO - "pgo_build": "True", 05:41:27 INFO - "builduid": "24c9737725dd49398922c66457171ff8", 05:41:27 INFO - "slavebuilddir": "test" 05:41:27 INFO - } 05:41:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:41:27 INFO - Running post-action listener: _resource_record_post_action 05:41:27 INFO - ##### 05:41:27 INFO - ##### Finished read-buildbot-config step (success) 05:41:27 INFO - ##### 05:41:27 INFO - ##### 05:41:27 INFO - ##### Running download-and-extract step. 05:41:27 INFO - ##### 05:41:27 INFO - Running pre-action listener: _resource_record_pre_action 05:41:27 INFO - Running main action method: download_and_extract 05:41:27 INFO - mkdir: /builds/slave/test/build/tests 05:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:27 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:41:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:41:28 INFO - Downloaded 1361 bytes. 05:41:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:28 INFO - Using the following test package requirements: 05:41:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:41:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:41:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'jsshell-linux-x86_64.zip'], 05:41:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:41:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:41:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:41:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:41:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:41:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:41:28 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')]} 05:41:28 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:29 INFO - Downloaded 24452072 bytes. 05:41:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:41:30 INFO - Return code: 0 05:41:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:30 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:33 INFO - Downloaded 24452072 bytes. 05:41:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:41:35 INFO - Return code: 0 05:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:35 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:41:36 INFO - Downloaded 10833377 bytes. 05:41:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:41:36 INFO - Return code: 0 05:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:36 INFO - https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:41:39 INFO - Downloaded 59329985 bytes. 05:41:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:39 INFO - mkdir: /builds/slave/test/properties 05:41:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:39 INFO - Contents: 05:41:39 INFO - build_url:https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:45 INFO - Running post-action listener: _resource_record_post_action 05:41:45 INFO - Running post-action listener: set_extra_try_arguments 05:41:45 INFO - ##### 05:41:45 INFO - ##### Finished download-and-extract step (success) 05:41:45 INFO - ##### 05:41:45 INFO - ##### 05:41:45 INFO - ##### Running populate-webroot step. 05:41:45 INFO - ##### 05:41:45 INFO - Running pre-action listener: _resource_record_pre_action 05:41:45 INFO - Running main action method: populate_webroot 05:41:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:45 INFO - '--tppagecycles', 05:41:45 INFO - '7'], 05:41:45 INFO - 'tests': ['tsvgm']}}, 05:41:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['damp', 'tps']}, 05:41:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'tests': ['damp', 'tps']}, 05:41:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['dromaeo_dom']}, 05:41:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['a11yr', 05:41:45 INFO - 'ts_paint', 05:41:45 INFO - 'tpaint', 05:41:45 INFO - 'sessionrestore', 05:41:45 INFO - 'sessionrestore_no_auto_restore', 05:41:45 INFO - 'tabpaint']}, 05:41:45 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:45 INFO - 'ts_paint', 05:41:45 INFO - 'tpaint', 05:41:45 INFO - 'sessionrestore', 05:41:45 INFO - 'sessionrestore_no_auto_restore', 05:41:45 INFO - 'tabpaint']}, 05:41:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:45 INFO - 'ts_paint', 05:41:45 INFO - 'tpaint', 05:41:45 INFO - 'sessionrestore', 05:41:45 INFO - 'sessionrestore_no_auto_restore', 05:41:45 INFO - 'tabpaint']}, 05:41:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:45 INFO - 'ts_paint', 05:41:45 INFO - 'tpaint', 05:41:45 INFO - 'sessionrestore', 05:41:45 INFO - 'sessionrestore_no_auto_restore', 05:41:45 INFO - 'tabpaint']}, 05:41:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['a11yr', 05:41:45 INFO - 'ts_paint', 05:41:45 INFO - 'tpaint', 05:41:45 INFO - 'sessionrestore', 05:41:45 INFO - 'sessionrestore_no_auto_restore', 05:41:45 INFO - 'tabpaint']}, 05:41:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['a11yr', 05:41:45 INFO - 'ts_paint', 05:41:45 INFO - 'tpaint', 05:41:45 INFO - 'sessionrestore', 05:41:45 INFO - 'sessionrestore_no_auto_restore', 05:41:45 INFO - 'tabpaint']}, 05:41:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['tsvgx', 05:41:45 INFO - 'tsvgr_opacity', 05:41:45 INFO - 'tart', 05:41:45 INFO - 'tscrollx', 05:41:45 INFO - 'cart']}, 05:41:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:45 INFO - 'tsvgr_opacity', 05:41:45 INFO - 'tart', 05:41:45 INFO - 'tscrollx', 05:41:45 INFO - 'cart']}, 05:41:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'talos_options': ['--disable-e10s'], 05:41:45 INFO - 'tests': ['tp5o']}, 05:41:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'tests': ['tp5o']}, 05:41:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'talos_options': ['--disable-e10s', 05:41:45 INFO - '--xperf_path', 05:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:45 INFO - 'tests': ['tp5n']}, 05:41:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:45 INFO - 'talos_options': ['--xperf_path', 05:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:45 INFO - 'tests': ['tp5n']}}, 05:41:45 INFO - 'talos.zip': {'path': '', 05:41:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:45 INFO - Running post-action listener: _resource_record_post_action 05:41:45 INFO - ##### 05:41:45 INFO - ##### Finished populate-webroot step (success) 05:41:45 INFO - ##### 05:41:45 INFO - ##### 05:41:45 INFO - ##### Running create-virtualenv step. 05:41:45 INFO - ##### 05:41:45 INFO - Running pre-action listener: _resource_record_pre_action 05:41:45 INFO - Running main action method: create_virtualenv 05:41:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:45 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 05:41:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:45 INFO - Using real prefix '/usr' 05:41:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:47 INFO - Installing pip.................done. 05:41:47 INFO - Return code: 0 05:41:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41: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')]} 05:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:47 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:41:47 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 05:41:47 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 05:41:47 INFO - Using env: {'DISPLAY': ':0', 05:41:47 INFO - 'HOME': '/home/cltbld', 05:41:47 INFO - 'LANG': 'en_US.UTF-8', 05:41:47 INFO - 'LANGUAGE': 'en_US:en', 05:41:47 INFO - 'LOGNAME': 'cltbld', 05:41:47 INFO - 'MAIL': '/var/mail/cltbld', 05:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:47 INFO - 'MOZ_NO_REMOTE': '1', 05:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:47 INFO - 'NO_EM_RESTART': '1', 05:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:47 INFO - 'PWD': '/builds/slave/test', 05:41:47 INFO - 'SHELL': '/bin/bash', 05:41:47 INFO - 'SHLVL': '1', 05:41:47 INFO - 'TERM': 'linux', 05:41:47 INFO - 'TMOUT': '86400', 05:41:47 INFO - 'USER': 'cltbld', 05:41:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:47 INFO - '_': '/tools/buildbot/bin/python'} 05:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:47 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 05:41:47 INFO - Cleaning up... 05:41:47 INFO - Return code: 0 05:41:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41: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')]} 05:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:47 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:41:47 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 05:41:47 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 05:41:47 INFO - Using env: {'DISPLAY': ':0', 05:41:47 INFO - 'HOME': '/home/cltbld', 05:41:47 INFO - 'LANG': 'en_US.UTF-8', 05:41:47 INFO - 'LANGUAGE': 'en_US:en', 05:41:47 INFO - 'LOGNAME': 'cltbld', 05:41:47 INFO - 'MAIL': '/var/mail/cltbld', 05:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:47 INFO - 'MOZ_NO_REMOTE': '1', 05:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:47 INFO - 'NO_EM_RESTART': '1', 05:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:47 INFO - 'PWD': '/builds/slave/test', 05:41:47 INFO - 'SHELL': '/bin/bash', 05:41:47 INFO - 'SHLVL': '1', 05:41:47 INFO - 'TERM': 'linux', 05:41:47 INFO - 'TMOUT': '86400', 05:41:47 INFO - 'USER': 'cltbld', 05:41:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:47 INFO - '_': '/tools/buildbot/bin/python'} 05:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:48 INFO - Downloading/unpacking psutil>=3.1.1 05:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:50 INFO - Installing collected packages: psutil 05:41:50 INFO - Running setup.py install for psutil 05:41:50 INFO - building 'psutil._psutil_linux' extension 05:41:50 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 05:41:50 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 05:41:50 INFO - building 'psutil._psutil_posix' extension 05:41:50 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 05:41:50 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 05:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:50 INFO - Successfully installed psutil 05:41:50 INFO - Cleaning up... 05:41:50 INFO - Return code: 0 05:41:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:41:50 INFO - Using env: {'DISPLAY': ':0', 05:41:50 INFO - 'HOME': '/home/cltbld', 05:41:50 INFO - 'LANG': 'en_US.UTF-8', 05:41:50 INFO - 'LANGUAGE': 'en_US:en', 05:41:50 INFO - 'LOGNAME': 'cltbld', 05:41:50 INFO - 'MAIL': '/var/mail/cltbld', 05:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:50 INFO - 'MOZ_NO_REMOTE': '1', 05:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:50 INFO - 'NO_EM_RESTART': '1', 05:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:50 INFO - 'PWD': '/builds/slave/test', 05:41:50 INFO - 'SHELL': '/bin/bash', 05:41:50 INFO - 'SHLVL': '1', 05:41:50 INFO - 'TERM': 'linux', 05:41:50 INFO - 'TMOUT': '86400', 05:41:50 INFO - 'USER': 'cltbld', 05:41:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:50 INFO - '_': '/tools/buildbot/bin/python'} 05:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:41:52 INFO - Installing collected packages: mozsystemmonitor 05:41:52 INFO - Running setup.py install for mozsystemmonitor 05:41:52 INFO - Successfully installed mozsystemmonitor 05:41:52 INFO - Cleaning up... 05:41:52 INFO - Return code: 0 05:41:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:52 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:41:52 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 05:41:52 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 05:41:52 INFO - Using env: {'DISPLAY': ':0', 05:41:52 INFO - 'HOME': '/home/cltbld', 05:41:52 INFO - 'LANG': 'en_US.UTF-8', 05:41:52 INFO - 'LANGUAGE': 'en_US:en', 05:41:52 INFO - 'LOGNAME': 'cltbld', 05:41:52 INFO - 'MAIL': '/var/mail/cltbld', 05:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:52 INFO - 'MOZ_NO_REMOTE': '1', 05:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:52 INFO - 'NO_EM_RESTART': '1', 05:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:52 INFO - 'PWD': '/builds/slave/test', 05:41:52 INFO - 'SHELL': '/bin/bash', 05:41:52 INFO - 'SHLVL': '1', 05:41:52 INFO - 'TERM': 'linux', 05:41:52 INFO - 'TMOUT': '86400', 05:41:52 INFO - 'USER': 'cltbld', 05:41:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:52 INFO - '_': '/tools/buildbot/bin/python'} 05:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:53 INFO - Downloading/unpacking jsonschema==2.5.1 05:41:53 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 05:41:53 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 05:41:53 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 05:41:53 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 05:41:53 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 05:41:53 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 05:41:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:41:55 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 05:41:55 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 05:41:55 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 05:41:55 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 05:41:55 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 05:41:55 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 05:41:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:55 INFO - warning: no files found matching '*.txt' 05:41:55 INFO - no previously-included directories found matching 'build' 05:41:55 INFO - no previously-included directories found matching 'dist' 05:41:55 INFO - no previously-included directories found matching '.git*' 05:41:55 INFO - Installing collected packages: jsonschema, functools32 05:41:55 INFO - Running setup.py install for functools32 05:41:55 INFO - warning: no files found matching '*.txt' 05:41:55 INFO - no previously-included directories found matching 'build' 05:41:55 INFO - no previously-included directories found matching 'dist' 05:41:55 INFO - no previously-included directories found matching '.git*' 05:41:55 INFO - Successfully installed jsonschema functools32 05:41:55 INFO - Cleaning up... 05:41:55 INFO - Return code: 0 05:41:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:41:55 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')]} 05:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:55 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')]} 05:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:55 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:41:55 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 05:41:55 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 05:41:55 INFO - Using env: {'DISPLAY': ':0', 05:41:55 INFO - 'HOME': '/home/cltbld', 05:41:55 INFO - 'LANG': 'en_US.UTF-8', 05:41:55 INFO - 'LANGUAGE': 'en_US:en', 05:41:55 INFO - 'LOGNAME': 'cltbld', 05:41:55 INFO - 'MAIL': '/var/mail/cltbld', 05:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:55 INFO - 'MOZ_NO_REMOTE': '1', 05:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:55 INFO - 'NO_EM_RESTART': '1', 05:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:55 INFO - 'PWD': '/builds/slave/test', 05:41:55 INFO - 'SHELL': '/bin/bash', 05:41:55 INFO - 'SHLVL': '1', 05:41:55 INFO - 'TERM': 'linux', 05:41:55 INFO - 'TMOUT': '86400', 05:41:55 INFO - 'USER': 'cltbld', 05:41:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:55 INFO - '_': '/tools/buildbot/bin/python'} 05:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:55 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 05:41:55 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 05:41:55 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 05:41:55 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 05:41:55 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 05:41:55 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 05:41:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41: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 05:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:41:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 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 05:41:58 INFO - Downloading docopt-0.6.1.tar.gz 05:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:58 INFO - Running setup.py install for blobuploader 05:41:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:41:58 INFO - Running setup.py install for requests 05:41:58 INFO - Running setup.py install for docopt 05:41:58 INFO - Successfully installed blobuploader requests docopt 05:41:58 INFO - Cleaning up... 05:41:58 INFO - Return code: 0 05:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:58 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')]} 05:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:58 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')]} 05:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:58 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:41:58 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 05:41:58 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 05:41:58 INFO - Using env: {'DISPLAY': ':0', 05:41:58 INFO - 'HOME': '/home/cltbld', 05:41:58 INFO - 'LANG': 'en_US.UTF-8', 05:41:58 INFO - 'LANGUAGE': 'en_US:en', 05:41:58 INFO - 'LOGNAME': 'cltbld', 05:41:58 INFO - 'MAIL': '/var/mail/cltbld', 05:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:58 INFO - 'MOZ_NO_REMOTE': '1', 05:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:58 INFO - 'NO_EM_RESTART': '1', 05:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:58 INFO - 'PWD': '/builds/slave/test', 05:41:58 INFO - 'SHELL': '/bin/bash', 05:41:58 INFO - 'SHLVL': '1', 05:41:58 INFO - 'TERM': 'linux', 05:41:58 INFO - 'TMOUT': '86400', 05:41:58 INFO - 'USER': 'cltbld', 05:41:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:58 INFO - '_': '/tools/buildbot/bin/python'} 05:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:59 INFO - Running setup.py (path:/tmp/pip-S9Xkkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:59 INFO - Running setup.py (path:/tmp/pip-hYfGED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:59 INFO - Running setup.py (path:/tmp/pip-celJ0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:59 INFO - Running setup.py (path:/tmp/pip-Zoceqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:59 INFO - Running setup.py (path:/tmp/pip-X2QmnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:59 INFO - Running setup.py (path:/tmp/pip-g5qjN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:59 INFO - Running setup.py (path:/tmp/pip-HRdHQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:59 INFO - Running setup.py (path:/tmp/pip-lO86_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:59 INFO - Running setup.py (path:/tmp/pip-SDtnwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:59 INFO - Running setup.py (path:/tmp/pip-d4w2ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:59 INFO - Running setup.py (path:/tmp/pip-ImuJ13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:59 INFO - Running setup.py (path:/tmp/pip-ghp4nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:00 INFO - Running setup.py (path:/tmp/pip-jNQKTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:00 INFO - Running setup.py (path:/tmp/pip-tuHnzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:00 INFO - Running setup.py (path:/tmp/pip-dY8TlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:00 INFO - Running setup.py (path:/tmp/pip-BY3lHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:00 INFO - Running setup.py (path:/tmp/pip-by_V3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:42:00 INFO - Running setup.py install for manifestparser 05:42:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:42:00 INFO - Running setup.py install for mozcrash 05:42:00 INFO - Running setup.py install for mozdebug 05:42:00 INFO - Running setup.py install for mozdevice 05:42:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:42:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:42:00 INFO - Running setup.py install for mozfile 05:42:00 INFO - Running setup.py install for mozhttpd 05:42:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Running setup.py install for mozinfo 05:42:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Running setup.py install for mozInstall 05:42:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Running setup.py install for mozleak 05:42:01 INFO - Running setup.py install for mozlog 05:42:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Running setup.py install for moznetwork 05:42:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Running setup.py install for mozprocess 05:42:01 INFO - Running setup.py install for mozprofile 05:42:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Running setup.py install for mozrunner 05:42:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:42:01 INFO - Running setup.py install for mozscreenshot 05:42:01 INFO - Running setup.py install for moztest 05:42:02 INFO - Running setup.py install for mozversion 05:42:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:42:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:42:02 INFO - Cleaning up... 05:42:02 INFO - Return code: 0 05:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:42:02 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 05:42:02 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 05:42:02 INFO - Using env: {'DISPLAY': ':0', 05:42:02 INFO - 'HOME': '/home/cltbld', 05:42:02 INFO - 'LANG': 'en_US.UTF-8', 05:42:02 INFO - 'LANGUAGE': 'en_US:en', 05:42:02 INFO - 'LOGNAME': 'cltbld', 05:42:02 INFO - 'MAIL': '/var/mail/cltbld', 05:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:02 INFO - 'MOZ_NO_REMOTE': '1', 05:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:02 INFO - 'NO_EM_RESTART': '1', 05:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:02 INFO - 'PWD': '/builds/slave/test', 05:42:02 INFO - 'SHELL': '/bin/bash', 05:42:02 INFO - 'SHLVL': '1', 05:42:02 INFO - 'TERM': 'linux', 05:42:02 INFO - 'TMOUT': '86400', 05:42:02 INFO - 'USER': 'cltbld', 05:42:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:02 INFO - '_': '/tools/buildbot/bin/python'} 05:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:42:02 INFO - Running setup.py (path:/tmp/pip-DMQ9fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:42:02 INFO - Running setup.py (path:/tmp/pip-gT3zqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:42:02 INFO - Running setup.py (path:/tmp/pip-cuLp_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:42:02 INFO - Running setup.py (path:/tmp/pip-IAknoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:42:02 INFO - Running setup.py (path:/tmp/pip-Cc2xwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:42:02 INFO - Running setup.py (path:/tmp/pip-MLbwXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:42:02 INFO - Running setup.py (path:/tmp/pip-zu1z8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:42:02 INFO - Running setup.py (path:/tmp/pip-qgybf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:42:02 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)) 05:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:42:02 INFO - Running setup.py (path:/tmp/pip-CaFnoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:42:03 INFO - Running setup.py (path:/tmp/pip-VHqprv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:42:03 INFO - Running setup.py (path:/tmp/pip-eopxQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:42:03 INFO - Running setup.py (path:/tmp/pip-S8VzJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:42:03 INFO - Running setup.py (path:/tmp/pip-UW8bYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:42:03 INFO - Running setup.py (path:/tmp/pip-i4IUCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:03 INFO - Running setup.py (path:/tmp/pip-JdXZhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:42:03 INFO - Running setup.py (path:/tmp/pip-TQ8Jnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:42:03 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)) 05:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:42:03 INFO - Running setup.py (path:/tmp/pip-Wq60U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:03 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)) 05:42:03 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)) 05:42:03 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)) 05:42:03 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)) 05:42:03 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)) 05:42:03 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)) 05:42:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:03 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 05:42:05 INFO - Downloading blessings-1.6.tar.gz 05:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:05 INFO - Installing collected packages: blessings 05:42:05 INFO - Running setup.py install for blessings 05:42:05 INFO - Successfully installed blessings 05:42:05 INFO - Cleaning up... 05:42:05 INFO - Return code: 0 05:42:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:05 INFO - Reading from file tmpfile_stdout 05:42:05 INFO - Current package versions: 05:42:05 INFO - argparse == 1.2.1 05:42:05 INFO - blessings == 1.6 05:42:05 INFO - blobuploader == 1.2.4 05:42:05 INFO - docopt == 0.6.1 05:42:05 INFO - functools32 == 3.2.3-2 05:42:05 INFO - jsonschema == 2.5.1 05:42:05 INFO - manifestparser == 1.1 05:42:05 INFO - mozInstall == 1.12 05:42:05 INFO - mozcrash == 0.17 05:42:05 INFO - mozdebug == 0.1 05:42:05 INFO - mozdevice == 0.48 05:42:05 INFO - mozfile == 1.2 05:42:05 INFO - mozhttpd == 0.7 05:42:05 INFO - mozinfo == 0.9 05:42:05 INFO - mozleak == 0.1 05:42:05 INFO - mozlog == 3.2 05:42:05 INFO - moznetwork == 0.27 05:42:05 INFO - mozprocess == 0.22 05:42:05 INFO - mozprofile == 0.28 05:42:05 INFO - mozrunner == 6.11 05:42:05 INFO - mozscreenshot == 0.1 05:42:05 INFO - mozsystemmonitor == 0.3 05:42:05 INFO - moztest == 0.7 05:42:05 INFO - mozversion == 1.4 05:42:05 INFO - psutil == 3.1.1 05:42:05 INFO - requests == 1.2.3 05:42:05 INFO - wsgiref == 0.1.2 05:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42: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')]} 05:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42: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')]} 05:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:05 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:42:05 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 05:42:05 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 05:42:05 INFO - Using env: {'DISPLAY': ':0', 05:42:05 INFO - 'HOME': '/home/cltbld', 05:42:05 INFO - 'LANG': 'en_US.UTF-8', 05:42:05 INFO - 'LANGUAGE': 'en_US:en', 05:42:05 INFO - 'LOGNAME': 'cltbld', 05:42:05 INFO - 'MAIL': '/var/mail/cltbld', 05:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:05 INFO - 'MOZ_NO_REMOTE': '1', 05:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:05 INFO - 'NO_EM_RESTART': '1', 05:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:05 INFO - 'PWD': '/builds/slave/test', 05:42:05 INFO - 'SHELL': '/bin/bash', 05:42:05 INFO - 'SHLVL': '1', 05:42:05 INFO - 'TERM': 'linux', 05:42:05 INFO - 'TMOUT': '86400', 05:42:05 INFO - 'USER': 'cltbld', 05:42:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:05 INFO - '_': '/tools/buildbot/bin/python'} 05:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 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)) 05:42:06 INFO - Cleaning up... 05:42:06 INFO - Return code: 0 05:42:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42:06 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')]} 05:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 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')]} 05:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:42:06 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 05:42:06 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 05:42:06 INFO - Using env: {'DISPLAY': ':0', 05:42:06 INFO - 'HOME': '/home/cltbld', 05:42:06 INFO - 'LANG': 'en_US.UTF-8', 05:42:06 INFO - 'LANGUAGE': 'en_US:en', 05:42:06 INFO - 'LOGNAME': 'cltbld', 05:42:06 INFO - 'MAIL': '/var/mail/cltbld', 05:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:06 INFO - 'MOZ_NO_REMOTE': '1', 05:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:06 INFO - 'NO_EM_RESTART': '1', 05:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:06 INFO - 'PWD': '/builds/slave/test', 05:42:06 INFO - 'SHELL': '/bin/bash', 05:42:06 INFO - 'SHLVL': '1', 05:42:06 INFO - 'TERM': 'linux', 05:42:06 INFO - 'TMOUT': '86400', 05:42:06 INFO - 'USER': 'cltbld', 05:42:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:06 INFO - '_': '/tools/buildbot/bin/python'} 05:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:42:06 INFO - Cleaning up... 05:42:06 INFO - Return code: 0 05:42:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:42:06 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')]} 05:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 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')]} 05:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:06 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 0x7f0e90464f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ce190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', '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 05:42:06 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 05:42:06 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 05:42:06 INFO - Using env: {'DISPLAY': ':0', 05:42:06 INFO - 'HOME': '/home/cltbld', 05:42:06 INFO - 'LANG': 'en_US.UTF-8', 05:42:06 INFO - 'LANGUAGE': 'en_US:en', 05:42:06 INFO - 'LOGNAME': 'cltbld', 05:42:06 INFO - 'MAIL': '/var/mail/cltbld', 05:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:06 INFO - 'MOZ_NO_REMOTE': '1', 05:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:06 INFO - 'NO_EM_RESTART': '1', 05:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:06 INFO - 'PWD': '/builds/slave/test', 05:42:06 INFO - 'SHELL': '/bin/bash', 05:42:06 INFO - 'SHLVL': '1', 05:42:06 INFO - 'TERM': 'linux', 05:42:06 INFO - 'TMOUT': '86400', 05:42:06 INFO - 'USER': 'cltbld', 05:42:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:06 INFO - '_': '/tools/buildbot/bin/python'} 05:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:06 INFO - Downloading/unpacking flake8 05:42:06 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 05:42:06 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 05:42:06 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 05:42:06 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 05:42:06 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 05:42:06 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 05:42:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:42:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:42:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:08 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 05:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:42:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:09 INFO - no previously-included directories found matching 'docs/_build' 05:42:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:42:09 INFO - Running setup.py install for pep8 05:42:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:09 INFO - no previously-included directories found matching 'docs/_build' 05:42:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:42:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:42:09 INFO - Cleaning up... 05:42:09 INFO - Return code: 0 05:42:09 INFO - Running post-action listener: _resource_record_post_action 05:42:09 INFO - Running post-action listener: _start_resource_monitoring 05:42:09 INFO - Starting resource monitoring. 05:42:09 INFO - ##### 05:42:09 INFO - ##### Finished create-virtualenv step (success) 05:42:09 INFO - ##### 05:42:09 INFO - ##### 05:42:09 INFO - ##### Running install step. 05:42:09 INFO - ##### 05:42:09 INFO - Running pre-action listener: _resource_record_pre_action 05:42:09 INFO - Running main action method: install 05:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:09 INFO - Reading from file tmpfile_stdout 05:42:09 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:09 INFO - Reading from file tmpfile_stdout 05:42:09 INFO - Output received: 05:42:09 INFO - Usage: mozinstall [options] installer 05:42:09 INFO - Options: 05:42:09 INFO - -h, --help show this help message and exit 05:42:09 INFO - -d DEST, --destination=DEST 05:42:09 INFO - Directory to install application into. [default: 05:42:09 INFO - "/builds/slave/test"] 05:42:09 INFO - --app=APP Application being installed. [default: firefox] 05:42:09 INFO - mkdir: /builds/slave/test/build/application 05:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:42:26 INFO - Reading from file tmpfile_stdout 05:42:26 INFO - Output received: 05:42:26 INFO - /builds/slave/test/build/application/firefox/firefox 05:42:26 INFO - Running post-action listener: _resource_record_post_action 05:42:26 INFO - ##### 05:42:26 INFO - ##### Finished install step (success) 05:42:26 INFO - ##### 05:42:26 INFO - ##### 05:42:26 INFO - ##### Running run-tests step. 05:42:26 INFO - ##### 05:42:26 INFO - Running pre-action listener: _resource_record_pre_action 05:42:26 INFO - Running main action method: run_tests 05:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:42:26 INFO - Python 2.7.3 05:42:26 INFO - Return code: 0 05:42:26 INFO - grabbing minidump binary from tooltool 05:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:26 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 0x2660110>, '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 0x25cc230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:42:26 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 05:42:26 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 05:42:26 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 05:42:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:26 INFO - Return code: 0 05:42:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:42:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:42:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:42:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:42:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:42:27 INFO - Return code: 0 05:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:42:27 INFO - Using env: {'DISPLAY': ':0', 05:42:27 INFO - 'HOME': '/home/cltbld', 05:42:27 INFO - 'LANG': 'en_US.UTF-8', 05:42:27 INFO - 'LANGUAGE': 'en_US:en', 05:42:27 INFO - 'LOGNAME': 'cltbld', 05:42:27 INFO - 'MAIL': '/var/mail/cltbld', 05:42:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:42:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:27 INFO - 'MOZ_NO_REMOTE': '1', 05:42:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:27 INFO - 'NO_EM_RESTART': '1', 05:42:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:27 INFO - 'PWD': '/builds/slave/test', 05:42:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:42:27 INFO - 'SHELL': '/bin/bash', 05:42:27 INFO - 'SHLVL': '1', 05:42:27 INFO - 'TERM': 'linux', 05:42:27 INFO - 'TMOUT': '86400', 05:42:27 INFO - 'USER': 'cltbld', 05:42:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652', 05:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:27 INFO - '_': '/tools/buildbot/bin/python'} 05:42:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:42:27 INFO - mozversion application_buildid: 20160610030239 05:42:27 INFO - mozversion application_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 05:42:27 INFO - mozversion application_display_name: Nightly 05:42:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:27 INFO - mozversion application_name: Firefox 05:42:27 INFO - mozversion application_remotingname: firefox 05:42:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:42:27 INFO - mozversion application_vendor: Mozilla 05:42:27 INFO - mozversion application_version: 50.0a1 05:42:27 INFO - mozversion platform_buildid: 20160610030239 05:42:27 INFO - mozversion platform_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 05:42:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:42:27 INFO - mozversion platform_version: 50.0a1 05:42:27 INFO - using testdate: 1465562547 05:42:27 INFO - actual date: 1465562547 05:42:27 INFO - starting webserver on 'localhost:34276' 05:42:27 INFO - SUITE-START | Running 2 tests 05:42:27 INFO - TEST-START | dromaeo_css 05:42:27 INFO - operating with platform_type : linux_ 05:42:27 INFO - Initialising browser for dromaeo_css test... 05:42:27 INFO - TEST-INFO | started process 18663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxRXbRc/profile http://localhost:34276/getInfo.html) 05:42:32 INFO - PROCESS | 18663 | __metrics Screen width/height:1600/1200 05:42:32 INFO - PROCESS | 18663 | colorDepth:24 05:42:32 INFO - PROCESS | 18663 | Browser inner width/height: 1024/697 05:42:32 INFO - PROCESS | 18663 | __metrics 05:42:33 ERROR - PROCESS | 18663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:42:33 INFO - PROCESS | 18663 | console.error: PushService: 05:42:33 INFO - PROCESS | 18663 | stateChangeProcessEnqueue: Error transitioning state 05:42:33 INFO - PROCESS | 18663 | UnknownError 05:42:34 INFO - TEST-INFO | 18663: exit 0 05:42:34 INFO - Browser initialized. 05:42:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:42:34 INFO - TEST-INFO | started process 18743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxRXbRc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:46 INFO - PROCESS | 18743 | RSS: Main: 177389568 05:42:46 INFO - PROCESS | 18743 | 05:43:37 INFO - PROCESS | 18743 | 1465562617716 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] 05:45:45 INFO - PROCESS | 18743 | Cycle 1(1): loaded http://localhost:34276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34276/tests/dromaeo/cssquery-ext.html) 05:45:46 INFO - PROCESS | 18743 | RSS: Main: 276148224 05:45:46 INFO - PROCESS | 18743 | 05:48:49 INFO - PROCESS | 18743 | Cycle 1(1): loaded http://localhost:34276/tests/dromaeo/cssquery-ext.html (next: http://localhost:34276/tests/dromaeo/cssquery-jquery.html) 05:48:49 INFO - PROCESS | 18743 | RSS: Main: 253751296 05:48:49 INFO - PROCESS | 18743 | 05:51:51 INFO - PROCESS | 18743 | Cycle 1(1): loaded http://localhost:34276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34276/tests/dromaeo/cssquery-mootools.html) 05:51:52 INFO - PROCESS | 18743 | RSS: Main: 257818624 05:51:52 INFO - PROCESS | 18743 | 05:54:54 INFO - PROCESS | 18743 | Cycle 1(1): loaded http://localhost:34276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34276/tests/dromaeo/cssquery-prototype.html) 05:54:54 INFO - PROCESS | 18743 | RSS: Main: 259735552 05:54:54 INFO - PROCESS | 18743 | 05:57:57 INFO - PROCESS | 18743 | Cycle 1(1): loaded http://localhost:34276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34276/tests/dromaeo/cssquery-yui.html) 05:57:58 INFO - PROCESS | 18743 | RSS: Main: 244867072 05:57:58 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | Cycle 1(1): loaded http://localhost:34276/tests/dromaeo/cssquery-yui.html (next: http://localhost:34276/tests/dromaeo/cssquery-dojo.html) 06:01:00 INFO - PROCESS | 18743 | RSS: Main: 306995200 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | __start_tp_report 06:01:00 INFO - PROCESS | 18743 | _x_x_mozilla_page_load 06:01:00 INFO - PROCESS | 18743 | _x_x_mozilla_page_load_details 06:01:00 INFO - PROCESS | 18743 | |i|pagename|runs| 06:01:00 INFO - PROCESS | 18743 | |0;dojo.html;3090.675479074696;3096.3188098618302;3124.8750049998002;3147.6694947030574;3148.748100151988;5278.049951008817;5335.493128152824;5343.038253114438;5423.050966080935;5434.510894019542;5344.331958505187;5359.651622644526;5373.650712703671;5373.892522149565;5407.107827208506;4804.423469183694;4869.4887036861155;4909.410870695521;4923.729194894279;5028.798848046092;4943.728094954776;4951.801927922878;4993.425756038066;4997.100521906055;5019.447860735316;4787.353707249512;4792.544708252728;4820.373351464287;4864.635152363587;4894.681845680055;4861.124997500448;4871.902561948741;4948.035133149037;4952.356193694833;4997.750112494397;4801.15979703554;4894.559489645913;4913.336699545552;4924.496020233551;4936.185529387647;5301.469853014706;5380.273663055476;5383.219433182206;5426.75579598919;5464.207689884945;5753.597248192628;5769.509591684712;5771.50942169916;5804.361520232771;5806.65160090396;5611.831645050655;5692.48767610917;5779.711014449261;5814.040683287252;5857.70711464425;5450.482204190595;5456.945430545684;5470.042742520083;5471.015217260931;5473.8357849264985;5960.970195149083;5963.7912673056235;5964.373740757244;5964.612300200473;5968.940310596925;5496.972515137479;5517.917231241535;5584.022796010763;5601.159826026129;5730.19777231188;5710.343310519261;5755.884882302415;5757.050086735725;5763.682997435181;5766.567507436959;5669.036263835158;5675.858103547444;5679.517241034476;5680.318361796611;5681.57388195887;5552.167174923713;5617.915731264035;5619.213310136584;5639.8590035249445;5652.406497317723;4378.671599630041;4384.69307148503;4407.735535867858;4411.09572537629;4450.799714012877;3897.0841852164717;3943.684505239574;3950.545687245946;3965.861194858166;3997.6801855851463;5338.386085600206;5343.412224655285;5389.56883449331;5451.536619387396;5469.917951230735;5673.858153546112;5703.572232082527;5706.315242170883;5709.74306156224;5731.111677689964;5427.43011983744;5434.864128396822;5435.239066530688;5437.8368648940595;5441;4866.343043689128;4942.382202224722;4991.825286114969;5000.224965130411;5009.073321435546;5932.2584676915385;5948.910766338508;5972.432618901197;5990.251218597676;5993.130996005555;5567.331920169606;5769.048107062287;5782.537397008314;5785.566082543742;5790.565707571865;5937.673427961504;5953.732082056231;5999.040153575407;6041.395860413923;6060.424259695322;5694.601377903673;5716.79991200306;5725.7137143141845;5728.054870946414;5728.312602487728;5617.466340697627;5718.428157184248;5831.0378787499585;5835.766569337179;5838.036723940672;5612.102063669793;5668.631538949955;5670.206171135962;5670.376258611632;5722;5596.384397716167;5640.210370548209;5644.068728659725;5653.349864765604;5661.264035675335;5439.211314359475;5444.156155795858;5488.9725551371985;5561;5576.693281869536;5683.715814209356;5687.232223649919;5687.317521897234;5693.060644993529;5694.174344720075;5480.72596370172;5510.972445137749;5518.613697041169;5525.751341189576;5527.778888844562 06:01:00 INFO - PROCESS | 18743 | |1;ext.html;577.3591313641857;617.428878287584;618.3260246331498;623.5198896849427;638.9872202555949;29508.704912950863;31594.68405315949;31661.366772664533;31731.04806855795;41724;43689.56310436902;44501;44538;44656.77671611645;44689.776551117284;8847.336449766277;9097;9098.454092754457;9099.681511147111;9100.180983711465;8610.311175105977;8687.869681954775;8695.043545210021;8695.826083478327;8698.39111262212;8918.554072296392;8956.462612243253;8965.462072275684;8966.506842123681;8967.282617390625;8969.14793094655;8992.280617550581;9010.954945225298;9016.323775716815;9070.546472676373;8872;8952;8963.955180224057;8966.506842123681;8967.10328967098;40763.38854917179;41265.58734412648;41434.79282603598;41456.79271603622;41477.585224147675;3238.9838050809594;3248.025592322294;3257.4788033914697;3355.4128027595075;3898.5126859142606;27698.5845212322;27931.58102628462;28542.714572854213;28744.856275718696;29341.85329073341;3933.3706606943038;3985.54341966014;4047.5750046245016;4059.3505039193883;4169.958300416987;338342;338656;338976;339191.99999999756;339627;55982.44017559854;56186.7190664044;56467.71766141143;56551.15173272404;56631.71684141635;34739.13152171166;35601.465978010354;35607.4658880117;37449;59088;16081.758773618405;16263.105529196007;16284.918575407284;16288.755668664979;16291.755623665655;12233.632991010283;12307.56923507673;12318.630441086782;12337.259764414164;12364.505419783109;19373.709394359095;19464.416067517996;19494.261565172357;19513.312453006918;19622.70565941512;5868.483625392118;6023.819285421444;6153.538484613672;6165.167702360124;6189.412005859436;808.8382323535199;882.5278476015301;888.595688961521;919.9586018629178;984.3552473130111;31522.842385787924;32293.677063229537;32421.675783241866;32858.671413286036;32969.835150824096;1065.6802959112235;1102.443266150589;1147.1568397228032;1153.9423028848523;1205.9457324420423;16277.674446511004;17039.91480042592;17054.57363565896;17103.216605296035;17128.48614541541;573725;575095.1245243831;577020;578759;586903;57803.4219657798;57981;57981.4201857976;58559;58624.12063819046;1246.875312468746;1365.528892532075;1378.5175188683882;1395.413926151019;1396.5391420831102;28362.716372836006;29533.26166845846;29851.85074074616;29944.401111978073;29994;47433.28850067183;48429;48472.27291590699;48477.75761121172;48526.75736621294;394771;403891;404057;404446;404610;23343;24991.87504062468;25288.873555632104;25550.361240969123;27256.863715681295;46564;47157.528424716686;47503;47662;47713.52286477091;37695.623043770305;37985.4302185473;38256.42615360828;38312.616873830906;38482.80758596189;39154.4126838092;39483.40774888321;39485.210295794495;39548;40116.79941600273;38465.80767096147;39068;39550.40674389829;39724.2055158901;39918.600813991485;33505;35206;35492.82253588716;36082.27835443224;36217.275654486235;27387;27591.448171036067;27832.8608356965;27838.3040423991;27851.683557043667 06:01:00 INFO - PROCESS | 18743 | |2;jquery.html;368.86352049741583;379.69244911621587;388.72594820651443;395.3772807827671;398.47600405466807;15056.849431505681;16773;17869.285228590856;19593.314234001813;19613.901930490363;16489.505314840542;19078.90460547699;19079.71380429291;19173.42479725607;19508.804911950912;5610.635308704921;5805.4194580542035;5875;5876.9118463223085;5877.441643043904;5643.6049476536655;5754.942450575503;5796;5796.1016042513265;5808.506276966463;5770.913436298459;5781.942180578203;5788.82633520995;5793.942060579404;5939.762409503636;6195.535334849882;6273.278572964122;6325.87348253037;6335.176427064475;6338.461230795388;5461.563074953994;5559.527440167591;5694.629849059839;5786.07422812348;5798.3911689272445;13798.65503362414;13813.51652692151;15895.60260993473;20386.898065509577;20389.490262743402;2189.912403503858;2314.172817415943;2699.784017278613;2720.3471166919994;2903.840288784116;10030.849537256947;10392.376457412503;11571.594994175248;12481.75036499274;14675.63310917225;1818.3817502049235;1960.2061165228106;1992.6413245615784;1994.0926878270352;2091;74010.25989740141;75153.62423187903;77909;80792;83676.58161709213;10037.648682296085;10161.491925403849;10288.890777390618;10360.430176340373;10554.261201715806;14143.929280353532;14183.432662693376;14220;14512.637184070483;14691.265436728121;7639.312461878458;7792.376609871197;7894.565798881116;7962.84074318522;7972.840543189103;7435.293647103516;7447.255274472509;7554.2823431773895;7604.353629941406;7648.80877978055;4393.406890069864;4708.8351907683755;4740.66815322931;4834.758262086882;4848.660593758474;1826.8264514871066;1828.232142500153;1830.4508647405726;1885.77370715515;1885.86798924074;952.7570469530225;967.2503809547517;995.4674249276748;1016.3393794033938;1042.0257059649252;17967.06371412581;18350.265989360276;18490.907545462185;18520.536986575444;18602.25590976346;953.6709835106877;958.496789185683;963.9855402168973;1017.4353233955078;1070.641335152717;9646.710598682052;10121.797564048678;10158.288919775545;10479.895201048044;10625.203109766644;452592;465951.3834031653;468892;470670;471309;54170.45829541733;67726.66136669384;90255.54872225598;93515.53242233745;95294;944.5843828715481;948.8481842905102;979.3340528440729;979.6424305128719;985.7239972807625;16401.140532780213;16670.083145426634;16720.331186752395;17013.48959531216;17307.913460432617;40295.194096117324;40449.79775101106;40635.390469143575;41993.16013679648;42273.577264226966;57176.42823571711;57308.71345643245;57382.98319117789;57741.71129144495;57957;6984.720611175496;7391.926080739124;8152.714654987047;8428.536430496137;8706.434081784664;12573.434195461408;12888.226706397647;13080.476780928657;13250.867491325349;13377.398017089448;11314.377709226072;11366.715832104264;11562.653120406401;11705.122115841516;11712.648620541397;11032.172587056164;11466.197366184288;11523.366214858263;11592.942035289769;11724.41377931083;11620.88379116198;11639.6508104757;11758.70603234926;12080.154389192672;12188.146829722189;7630.580318082559;7719.498232614862;7827.491213071132;7873.409494287836;7911.762647120596;10727.731806704895;11990.820137698116;12020.519179233082;12117.091218158497;12119.030477561597 06:01:00 INFO - PROCESS | 18743 | |3;mootools.html;1226.8957138643216;1402.2287741742043;1447.5584946591289;1514.9772753408695;1716.8540674042706;8686.565671716413;8868.201861832435;8941.597628106734;9226.261899048077;9246.491442970633;8771.56142192891;8964.520854059088;8965.013848476663;9001.414908030973;9036.09639036096;2055.239561362298;2280.144945645383;2360.2329242996093;2397.928062158134;2428.805695544352;2364.76352364763;2414.6860908081926;2415.492746523232;2415.855048697075;2416.9395765105924;2378.5480758655885;2398.9280321590295;2406.74729153439;2409.518096380722;2412.1316326122583;2011.6982452632076;2204.680321353411;2281.418238349227;2284.4745708486976;2307.2501437032947;2353.5881220786296;2369.5379401016808;2374.382660508263;2377.4531857672832;2381.3213234228333;8989.280857531447;9045.547722613843;9053.818923621557;9055.547222638841;9065.22945549629;5206.687598744087;5319.813806516792;5331.306930099101;5332.173513105436;5348.304720386325;3318.0875259303643;3462.3940810358085;3509.929801403983;3546.184377593168;3552.5381700379044;1107.7119948813286;1150.068444559909;1187.994060029703;1203.7472130852532;1213;12780.233186008776;12923.483060677561;12968.286744229064;12968.481260749559;13000.414981325863;4522.819087236474;4621.12198682256;4668.8599342019115;4677.929831052537;4685.648576356787;10895.509702063426;10926.344419334866;10935.83596246057;10936.890631093745;10940;5309.442508536626;5417.945820541744;5420.728963551806;5421;5428.212909128154;4364.410804541346;4768.332433459249;4926.581240594518;4930.433000204951;5008.874778130576;3829.5787463379006;3938.940915886264;3949.881503554898;4016.357382818735;4096.713230073866;1212.6968257935516;1217.4156404925686;1220.7619514194823;1236.097648716442;1243.9937800311122;855.2089317381398;958.8705524754068;972.5040229483014;976.6435251133428;1006.1598565198142;6259.624422534663;6330.3669633036325;6381.329960354189;6409.583377080475;6473.676316184266;407.6392392732394;410.21239220695736;416.5792549524941;458.5368777534714;459.91261660284437;4265.232258193555;4328.654112171465;4382.276924307517;4399.868003959887;4404.185225733249;11135;11535.250208736405;11650.126240531994;11664.591739289084;11673.941630291794;11299.209055366046;11449.885501144881;11489;11510.482028308747;11510.712232194095;7855.607219638995;8117.878231826528;8228.958855205685;8390.244877960891;8506.36202284831;6276.937230627818;6587.901181482377;6618.867622647424;6639.136912201383;6678;10464.476776161313;10678.359298441808;10799.298045627009;10817.972292632187;10833.02502774754;10675.412852293199;10771.622993195515;10799.730006749895;10936.50785714629;10955.671329860117;7327.4504412168235;7938;8109.7161599343735;8142.918570814216;8286.958565207135;8921.821563568563;8941.687040953535;9006.86489702668;9035.864462033207;9040.141186587263;7868.095169055403;8024.0772311184965;8129.959350203448;8134.593270336341;8191.262786349019;7691.269329413697;7875.094364147967;7946.483478573874;8028.518288902451;8074.515529068275;7195.352418282379;7256.492045556972;7351.558906465629;7357.411407087313;7366.668499917624;5320;5411.567074634098;5429.918551221814;5458.61789674719;5459.153831156177;5455.9454405455435;5467.234587157881;5555.666660000251;5658.009848276617;5670.177824215548 06:01:00 INFO - PROCESS | 18743 | |4;prototype.html;317.290854939211;331.7196968561566;333.726344397594;337.7450025230951;337.79563364164693;5206.895862082756;5280.947190528093;5329.600279979008;5331.386890507592;5382.38102618199;5283.973580132104;5299.224759705503;5308.283381743464;5334.413214546406;5340.599455040878;4169.457970463851;4169.687273454488;4173.791310434482;4185.183889141618;4201.7478951262865;4051.5948405159397;4125.2986992211245;4142.150859073898;4145.937810932838;4205.747655140686;4111.753294802322;4121.876343709693;4138.8344466221315;4144.440500532435;4164.687648426365;4114.526829414611;4170.895727606834;4179.393987871742;4183.97908010461;4184.309588917825;3709.2210635766523;3709.239605880788;3711.7751142123034;3714.9442758358377;3723.3111874303067;4944.728039957801;5168.689878607295;5174.7412629368755;5181.041507321158;5217.399999000126;4698.154332220199;4703.529647035303;4723.574878260939;4726.858194254178;4753.405824271966;5247.47525247476;5452.672839629635;5515.669059856422;5557.666540007572;5565.9443405566235;3915.1973845361917;3917.902052448683;3932.1742434088874;3939.566647668783;3947.782871942042;5421.756020979065;5488.396276409631;5666.971665141689;5703.201551782754;5708.372079071299;3972.3445631470486;3977.5823538528616;3981.343078392033;3984.242993831163;3988.202359528106;4010.9197816043516;4036.192761447722;4057.5333836609166;4065.288574499451;4094.2630326541507;4434.733915965053;4524.140413321458;4677.625789936865;4685.695429797121;4727.810887564528;5416.7020813855615;5457.5633949283965;5470.72646367688;5546.91679624806;5573.554115670737;1368.4594585139014;1379.9724005519834;1388.7361401333715;1389.305347326337;1397.3292819446722;848.4739461533889;878.3149143667949;890.8930928288647;905.2622112977901;905.542700936023;4693.741844198534;4769.379980602499;4796.112719146969;4796.232602783538;4796.937316953743;4930.7288099154175;5029.1450453423;5045.772940217699;5089.9745501272255;5106.693598384109;4662.018642077103;4795.44148151852;4804.654696684934;4834.694632449289;5060.822871199564;3046.573479712842;3057.9541306880415;3077.2306923269184;3079.6766339534474;3085.182426656938;5773.595848290579;5792.4497172768515;5833.38749431312;5879.647221166743;5881.088646190005;5571;5740.655560666373;5762.222100016528;5784;5821.592488525763;5836.358000619928;5880.500157486662;5883.411478900673;5883.823485295448;5886.852828679317;5371.543418809445;5636.633618814764;5643.266375371176;5721.713914304351;5736.799212027726;5550.222968784293;5590.217369568182;5592.916106258491;5666.291713535808;5691.573132015033;5544.473275038865;5703.914441283301;5852.600433822113;5865.3254875688135;5870.324912635102;4074.8166332514515;4105.58944105587;4109.602735069971;4129.834806607702;4131.967008247938;5473.589480788877;5679.318481782213;5727.713614319184;5729.656220626775;5748.367679555329;5503.972480137734;5540.695261760642;5551.500364967173;5574.331080270394;5594.720263986866;5494.450554944474;5516.613837031369;5545.72271386421;5556.944430555643;5572.829705761836;5199.63602547818;5438.75525601341;5462.481064298885;5526.778928842962;5549.223108764695;5501.422350653123;5546.278983732089;5574.832755017356;5575.661841158012;5607.710226647975;5420.214068960057;5422.912178811107;5492.313460817398;5513.731841676356;5560.944390556205 06:01:00 INFO - PROCESS | 18743 | |5;yui.html;722.2705067881438;786.0919153317625;801.5591424716405;822.5106061893175;842.5997651115721;11999.940000300008;14726.926365368172;15890.126043067627;15908.443204487845;16028.519144425656;14301.928490357534;14847.925760371183;14875.702485950302;14920.850791492081;15037.77443338348;815.922487363701;823.2508417340222;824.171707434028;826.5784449930549;829.3696790439279;639.7600899662626;796.7052190689453;810.3719617296583;813.0690359538326;818.7175424478545;860.5869182792263;861.7371701631;864.7276108025983;866.0386970462781;866.7183165471215;856.0113069404847;858.4849090545686;858.6994551906845;858.7337925243132;858.8883445152121;624.1418050181001;624.9312575616678;626.0890404461497;626.2234828812285;626.2891618013542;13352.33238338089;13399.330033498383;13401.396937137852;13403;13436;14387;14692.338844751905;14748.336324865406;15015;15197.696046079016;11157.832632510519;11266.830997535044;11554.480048397842;11753.823692644617;11909.523619055228;3812.370958791796;3858.401947698111;3920.607939206085;4049.271131196413;4095.28332541804;69647.65176174087;71066.289337107;73733.63133184353;74773.626131869;75194.24805751981;11452.255603385753;11492.965633093061;11605.361705106301;11736;11941.283522988648;21950.560988780137;21973;21981.67027494589;21983.120675173133;22024.889875550518;8087.595620218965;8218.424710270223;8381.706640267561;8538.01812791537;8592.613332399931;4642.094791515689;4695.81216751333;4746.454157771831;4749.073930583503;4870.220764677634;3565.8217089145437;3691.0956815579816;3692.2800053989213;3696.1868388954385;3705.0366904605;532.5659587436227;616.2881871438495;624.6751689121722;625.8278973282384;626.6616027345274;663.9535232533676;730.5908691132983;741.7403908632043;743.9367653749492;763.3587786259569;8597.699080532151;8637.179467950535;8849.159329863653;8876.423032502867;8959.1936725695;681.271039987209;729.6497681113095;737.9188289288174;744.2148533297315;748.8839229919371;4463.709858859163;4596.540345965377;4607.95392046082;4616.192166370872;4618.769061546909;65844.67077664581;91948.54025729962;103894;107018;108908.4554577222;88428;92477.53761231151;92541;92638.53680731553;93952;59074.704626476596;75617;77434;85583;86839.69740453898;9042.140996605312;9349.4635471817;9566.186874115778;9730.318877678494;9760.46317452547;38764;48908;49643.75178124086;49666;51762;66519.35248417675;66884.6655766718;75421.62289188518;76800;76873.61563192148;12716.809247861105;12905.096643234883;12934.353282335658;13195.472181112647;13203;13072.803907941197;13204.607919986292;13501.459941602227;13552.119112257671;13638.79541806854;12242.75514489723;12599.748005039664;12649.24104553693;12734.108612397044;13037.674058148623;12558.686032849251;12863.935680321538;13261.933690331873;13433.798493022417;13624.591262262147;12562.811557826457;13021.47914083464;13042.739145217232;13370.264635444755;13497.122687025312;10449.477526123816;10514.842277365693;10594.629187978384;10754.569817207224;10945.288556243819;9948.502574871372;10159.593616255563;10232.618596489676;10236.53935572886;10774.730631733955 06:01:00 INFO - PROCESS | 18743 | __end_tp_report 06:01:00 INFO - PROCESS | 18743 | __start_cc_report 06:01:00 INFO - PROCESS | 18743 | _x_x_mozilla_cycle_collect,937 06:01:00 INFO - PROCESS | 18743 | __end_cc_report 06:01:00 INFO - PROCESS | 18743 | __startTimestamp1465563660847__endTimestamp 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | ------- Summary: start ------- 06:01:00 INFO - PROCESS | 18743 | Number of tests: 6 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | [#0] dojo.html Cycles:165 Average:5346.70 Median:5518.61 stddev:602.40 (10.9%) stddev-sans-first:577.67 06:01:00 INFO - PROCESS | 18743 | Values: 3090.7 3096.3 3124.9 3147.7 3148.7 5278.0 5335.5 5343.0 5423.1 5434.5 5344.3 5359.7 5373.7 5373.9 5407.1 4804.4 4869.5 4909.4 4923.7 5028.8 4943.7 4951.8 4993.4 4997.1 5019.4 4787.4 4792.5 4820.4 4864.6 4894.7 4861.1 4871.9 4948.0 4952.4 4997.8 4801.2 4894.6 4913.3 4924.5 4936.2 5301.5 5380.3 5383.2 5426.8 5464.2 5753.6 5769.5 5771.5 5804.4 5806.7 5611.8 5692.5 5779.7 5814.0 5857.7 5450.5 5456.9 5470.0 5471.0 5473.8 5961.0 5963.8 5964.4 5964.6 5968.9 5497.0 5517.9 5584.0 5601.2 5730.2 5710.3 5755.9 5757.1 5763.7 5766.6 5669.0 5675.9 5679.5 5680.3 5681.6 5552.2 5617.9 5619.2 5639.9 5652.4 4378.7 4384.7 4407.7 4411.1 4450.8 3897.1 3943.7 3950.5 3965.9 3997.7 5338.4 5343.4 5389.6 5451.5 5469.9 5673.9 5703.6 5706.3 5709.7 5731.1 5427.4 5434.9 5435.2 5437.8 5441.0 4866.3 4942.4 4991.8 5000.2 5009.1 5932.3 5948.9 5972.4 5990.3 5993.1 5567.3 5769.0 5782.5 5785.6 5790.6 5937.7 5953.7 5999.0 6041.4 6060.4 5694.6 5716.8 5725.7 5728.1 5728.3 5617.5 5718.4 5831.0 5835.8 5838.0 5612.1 5668.6 5670.2 5670.4 5722.0 5596.4 5640.2 5644.1 5653.3 5661.3 5439.2 5444.2 5489.0 5561.0 5576.7 5683.7 5687.2 5687.3 5693.1 5694.2 5480.7 5511.0 5518.6 5525.8 5527.8 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | [#1] ext.html Cycles:180 Average:58668.30 Median:39549.20 stddev:120114.76 (303.7%) stddev-sans-first:120372.53 06:01:00 INFO - PROCESS | 18743 | Values: 577.4 617.4 618.3 623.5 639.0 29508.7 31594.7 31661.4 31731.0 41724.0 43689.6 44501.0 44538.0 44656.8 44689.8 8847.3 9097.0 9098.5 9099.7 9100.2 8610.3 8687.9 8695.0 8695.8 8698.4 8918.6 8956.5 8965.5 8966.5 8967.3 8969.1 8992.3 9011.0 9016.3 9070.5 8872.0 8952.0 8964.0 8966.5 8967.1 40763.4 41265.6 41434.8 41456.8 41477.6 3239.0 3248.0 3257.5 3355.4 3898.5 27698.6 27931.6 28542.7 28744.9 29341.9 3933.4 3985.5 4047.6 4059.4 4170.0 338342.0 338656.0 338976.0 339192.0 339627.0 55982.4 56186.7 56467.7 56551.2 56631.7 34739.1 35601.5 35607.5 37449.0 59088.0 16081.8 16263.1 16284.9 16288.8 16291.8 12233.6 12307.6 12318.6 12337.3 12364.5 19373.7 19464.4 19494.3 19513.3 19622.7 5868.5 6023.8 6153.5 6165.2 6189.4 808.8 882.5 888.6 920.0 984.4 31522.8 32293.7 32421.7 32858.7 32969.8 1065.7 1102.4 1147.2 1153.9 1205.9 16277.7 17039.9 17054.6 17103.2 17128.5 573725.0 575095.1 577020.0 578759.0 586903.0 57803.4 57981.0 57981.4 58559.0 58624.1 1246.9 1365.5 1378.5 1395.4 1396.5 28362.7 29533.3 29851.9 29944.4 29994.0 47433.3 48429.0 48472.3 48477.8 48526.8 394771.0 403891.0 404057.0 404446.0 404610.0 23343.0 24991.9 25288.9 25550.4 27256.9 46564.0 47157.5 47503.0 47662.0 47713.5 37695.6 37985.4 38256.4 38312.6 38482.8 39154.4 39483.4 39485.2 39548.0 40116.8 38465.8 39068.0 39550.4 39724.2 39918.6 33505.0 35206.0 35492.8 36082.3 36217.3 27387.0 27591.4 27832.9 27838.3 27851.7 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | [#2] jquery.html Cycles:180 Average:27577.29 Median:392.05 stddev:76747.91 (19576.0%) stddev-sans-first:76936.02 06:01:00 INFO - PROCESS | 18743 | Values: 368.9 379.7 388.7 395.4 398.5 15056.8 16773.0 17869.3 19593.3 19613.9 16489.5 19078.9 19079.7 19173.4 19508.8 5610.6 5805.4 5875.0 5876.9 5877.4 5643.6 5754.9 5796.0 5796.1 5808.5 5770.9 5781.9 5788.8 5793.9 5939.8 6195.5 6273.3 6325.9 6335.2 6338.5 5461.6 5559.5 5694.6 5786.1 5798.4 13798.7 13813.5 15895.6 20386.9 20389.5 2189.9 2314.2 2699.8 2720.3 2903.8 10030.8 10392.4 11571.6 12481.8 14675.6 1818.4 1960.2 1992.6 1994.1 2091.0 74010.3 75153.6 77909.0 80792.0 83676.6 10037.6 10161.5 10288.9 10360.4 10554.3 14143.9 14183.4 14220.0 14512.6 14691.3 7639.3 7792.4 7894.6 7962.8 7972.8 7435.3 7447.3 7554.3 7604.4 7648.8 4393.4 4708.8 4740.7 4834.8 4848.7 1826.8 1828.2 1830.5 1885.8 1885.9 952.8 967.3 995.5 1016.3 1042.0 17967.1 18350.3 18490.9 18520.5 18602.3 953.7 958.5 964.0 1017.4 1070.6 9646.7 10121.8 10158.3 10479.9 10625.2 452592.0 465951.4 468892.0 470670.0 471309.0 54170.5 67726.7 90255.5 93515.5 95294.0 944.6 948.8 979.3 979.6 985.7 16401.1 16670.1 16720.3 17013.5 17307.9 40295.2 40449.8 40635.4 41993.2 42273.6 57176.4 57308.7 57383.0 57741.7 57957.0 6984.7 7391.9 8152.7 8428.5 8706.4 12573.4 12888.2 13080.5 13250.9 13377.4 11314.4 11366.7 11562.7 11705.1 11712.6 11032.2 11466.2 11523.4 11592.9 11724.4 11620.9 11639.7 11758.7 12080.2 12188.1 7630.6 7719.5 7827.5 7873.4 7911.8 10727.7 11990.8 12020.5 12117.1 12119.0 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | [#3] mootools.html Cycles:180 Average:6017.58 Median:2490.68 stddev:3511.67 (141.0%) stddev-sans-first:3503.06 06:01:00 INFO - PROCESS | 18743 | Values: 1226.9 1402.2 1447.6 1515.0 1716.9 8686.6 8868.2 8941.6 9226.3 9246.5 8771.6 8964.5 8965.0 9001.4 9036.1 2055.2 2280.1 2360.2 2397.9 2428.8 2364.8 2414.7 2415.5 2415.9 2416.9 2378.5 2398.9 2406.7 2409.5 2412.1 2011.7 2204.7 2281.4 2284.5 2307.3 2353.6 2369.5 2374.4 2377.5 2381.3 8989.3 9045.5 9053.8 9055.5 9065.2 5206.7 5319.8 5331.3 5332.2 5348.3 3318.1 3462.4 3509.9 3546.2 3552.5 1107.7 1150.1 1188.0 1203.7 1213.0 12780.2 12923.5 12968.3 12968.5 13000.4 4522.8 4621.1 4668.9 4677.9 4685.6 10895.5 10926.3 10935.8 10936.9 10940.0 5309.4 5417.9 5420.7 5421.0 5428.2 4364.4 4768.3 4926.6 4930.4 5008.9 3829.6 3938.9 3949.9 4016.4 4096.7 1212.7 1217.4 1220.8 1236.1 1244.0 855.2 958.9 972.5 976.6 1006.2 6259.6 6330.4 6381.3 6409.6 6473.7 407.6 410.2 416.6 458.5 459.9 4265.2 4328.7 4382.3 4399.9 4404.2 11135.0 11535.3 11650.1 11664.6 11673.9 11299.2 11449.9 11489.0 11510.5 11510.7 7855.6 8117.9 8229.0 8390.2 8506.4 6276.9 6587.9 6618.9 6639.1 6678.0 10464.5 10678.4 10799.3 10818.0 10833.0 10675.4 10771.6 10799.7 10936.5 10955.7 7327.5 7938.0 8109.7 8142.9 8287.0 8921.8 8941.7 9006.9 9035.9 9040.1 7868.1 8024.1 8130.0 8134.6 8191.3 7691.3 7875.1 7946.5 8028.5 8074.5 7195.4 7256.5 7351.6 7357.4 7366.7 5320.0 5411.6 5429.9 5458.6 5459.2 5455.9 5467.2 5555.7 5658.0 5670.2 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | [#4] prototype.html Cycles:180 Average:4612.67 Median:5212.15 stddev:1349.02 (25.9%) stddev-sans-first:1313.71 06:01:00 INFO - PROCESS | 18743 | Values: 317.3 331.7 333.7 337.7 337.8 5206.9 5280.9 5329.6 5331.4 5382.4 5284.0 5299.2 5308.3 5334.4 5340.6 4169.5 4169.7 4173.8 4185.2 4201.7 4051.6 4125.3 4142.2 4145.9 4205.7 4111.8 4121.9 4138.8 4144.4 4164.7 4114.5 4170.9 4179.4 4184.0 4184.3 3709.2 3709.2 3711.8 3714.9 3723.3 4944.7 5168.7 5174.7 5181.0 5217.4 4698.2 4703.5 4723.6 4726.9 4753.4 5247.5 5452.7 5515.7 5557.7 5565.9 3915.2 3917.9 3932.2 3939.6 3947.8 5421.8 5488.4 5667.0 5703.2 5708.4 3972.3 3977.6 3981.3 3984.2 3988.2 4010.9 4036.2 4057.5 4065.3 4094.3 4434.7 4524.1 4677.6 4685.7 4727.8 5416.7 5457.6 5470.7 5546.9 5573.6 1368.5 1380.0 1388.7 1389.3 1397.3 848.5 878.3 890.9 905.3 905.5 4693.7 4769.4 4796.1 4796.2 4796.9 4930.7 5029.1 5045.8 5090.0 5106.7 4662.0 4795.4 4804.7 4834.7 5060.8 3046.6 3058.0 3077.2 3079.7 3085.2 5773.6 5792.4 5833.4 5879.6 5881.1 5571.0 5740.7 5762.2 5784.0 5821.6 5836.4 5880.5 5883.4 5883.8 5886.9 5371.5 5636.6 5643.3 5721.7 5736.8 5550.2 5590.2 5592.9 5666.3 5691.6 5544.5 5703.9 5852.6 5865.3 5870.3 4074.8 4105.6 4109.6 4129.8 4132.0 5473.6 5679.3 5727.7 5729.7 5748.4 5504.0 5540.7 5551.5 5574.3 5594.7 5494.5 5516.6 5545.7 5556.9 5572.8 5199.6 5438.8 5462.5 5526.8 5549.2 5501.4 5546.3 5574.8 5575.7 5607.7 5420.2 5422.9 5492.3 5513.7 5560.9 06:01:00 INFO - PROCESS | 18743 | 06:01:00 INFO - PROCESS | 18743 | [#5] yui.html Cycles:180 Average:19367.50 Median:4747.76 stddev:27071.67 (570.2%) stddev-sans-first:27111.41 06:01:00 INFO - PROCESS | 18743 | Values: 722.3 786.1 801.6 822.5 842.6 11999.9 14726.9 15890.1 15908.4 16028.5 14301.9 14847.9 14875.7 14920.9 15037.8 815.9 823.3 824.2 826.6 829.4 639.8 796.7 810.4 813.1 818.7 860.6 861.7 864.7 866.0 866.7 856.0 858.5 858.7 858.7 858.9 624.1 624.9 626.1 626.2 626.3 13352.3 13399.3 13401.4 13403.0 13436.0 14387.0 14692.3 14748.3 15015.0 15197.7 11157.8 11266.8 11554.5 11753.8 11909.5 3812.4 3858.4 3920.6 4049.3 4095.3 69647.7 71066.3 73733.6 74773.6 75194.2 11452.3 11493.0 11605.4 11736.0 11941.3 21950.6 21973.0 21981.7 21983.1 22024.9 8087.6 8218.4 8381.7 8538.0 8592.6 4642.1 4695.8 4746.5 4749.1 4870.2 3565.8 3691.1 3692.3 3696.2 3705.0 532.6 616.3 624.7 625.8 626.7 664.0 730.6 741.7 743.9 763.4 8597.7 8637.2 8849.2 8876.4 8959.2 681.3 729.6 737.9 744.2 748.9 4463.7 4596.5 4608.0 4616.2 4618.8 65844.7 91948.5 103894.0 107018.0 108908.5 88428.0 92477.5 92541.0 92638.5 93952.0 59074.7 75617.0 77434.0 85583.0 86839.7 9042.1 9349.5 9566.2 9730.3 9760.5 38764.0 48908.0 49643.8 49666.0 51762.0 66519.4 66884.7 75421.6 76800.0 76873.6 12716.8 12905.1 12934.4 13195.5 13203.0 13072.8 13204.6 13501.5 13552.1 13638.8 12242.8 12599.7 12649.2 12734.1 13037.7 12558.7 12863.9 13261.9 13433.8 13624.6 12562.8 13021.5 13042.7 13370.3 13497.1 10449.5 10514.8 10594.6 10754.6 10945.3 9948.5 10159.6 10232.6 10236.5 10774.7 06:01:00 INFO - PROCESS | 18743 | -------- Summary: end -------- 06:01:00 INFO - PROCESS | 18743 | 06:01:01 INFO - TEST-INFO | 18743: exit 0 06:01:01 INFO - TEST-OK | dromaeo_css | took 1113769ms 06:01:01 INFO - TEST-START | kraken 06:01:01 INFO - operating with platform_type : linux_ 06:01:01 INFO - Initialising browser for kraken test... 06:01:01 INFO - TEST-INFO | started process 18923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKaqjr/profile http://localhost:34276/getInfo.html) 06:01:05 INFO - PROCESS | 18923 | __metrics Screen width/height:1600/1200 06:01:05 INFO - PROCESS | 18923 | colorDepth:24 06:01:05 INFO - PROCESS | 18923 | Browser inner width/height: 1024/697 06:01:05 INFO - PROCESS | 18923 | __metrics 06:01:07 ERROR - PROCESS | 18923 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:01:07 INFO - PROCESS | 18923 | console.error: PushService: 06:01:07 INFO - PROCESS | 18923 | stateChangeProcessEnqueue: Error transitioning state 06:01:07 INFO - PROCESS | 18923 | UnknownError 06:01:08 INFO - TEST-INFO | 18923: exit 0 06:01:08 INFO - Browser initialized. 06:01:08 INFO - Running cycle 1/1 for kraken test... 06:01:08 INFO - TEST-INFO | started process 19006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKaqjr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:19 INFO - PROCESS | 19006 | RSS: Main: 173006848 06:01:19 INFO - PROCESS | 19006 | 06:01:22 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34276/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:23 INFO - PROCESS | 19006 | RSS: Main: 231809024 06:01:23 INFO - PROCESS | 19006 | 06:01:25 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34276/tests/kraken/driver.html?testName=audio-dft) 06:01:26 INFO - PROCESS | 19006 | RSS: Main: 218349568 06:01:26 INFO - PROCESS | 19006 | 06:01:29 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34276/tests/kraken/driver.html?testName=audio-fft) 06:01:30 INFO - PROCESS | 19006 | RSS: Main: 285360128 06:01:30 INFO - PROCESS | 19006 | 06:01:32 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34276/tests/kraken/driver.html?testName=audio-oscillator) 06:01:32 INFO - PROCESS | 19006 | RSS: Main: 197038080 06:01:32 INFO - PROCESS | 19006 | 06:01:35 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:35 INFO - PROCESS | 19006 | RSS: Main: 201314304 06:01:35 INFO - PROCESS | 19006 | 06:01:38 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34276/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:39 INFO - PROCESS | 19006 | RSS: Main: 234958848 06:01:39 INFO - PROCESS | 19006 | 06:01:42 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34276/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:43 INFO - PROCESS | 19006 | RSS: Main: 237363200 06:01:43 INFO - PROCESS | 19006 | 06:01:46 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34276/tests/kraken/driver.html?testName=json-parse-financial) 06:01:46 INFO - PROCESS | 19006 | RSS: Main: 237056000 06:01:46 INFO - PROCESS | 19006 | 06:01:48 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:48 INFO - PROCESS | 19006 | RSS: Main: 220606464 06:01:48 INFO - PROCESS | 19006 | 06:01:50 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:51 INFO - PROCESS | 19006 | RSS: Main: 224546816 06:01:51 INFO - PROCESS | 19006 | 06:01:53 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:54 INFO - PROCESS | 19006 | RSS: Main: 232787968 06:01:54 INFO - PROCESS | 19006 | 06:01:56 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:57 INFO - PROCESS | 19006 | RSS: Main: 238432256 06:01:57 INFO - PROCESS | 19006 | 06:01:59 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:02:00 INFO - PROCESS | 19006 | RSS: Main: 237580288 06:02:00 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | Cycle 1(1): loaded http://localhost:34276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34276/tests/kraken/driver.html?testName=ai-astar) 06:02:02 INFO - PROCESS | 19006 | RSS: Main: 281190400 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | __start_tp_report 06:02:02 INFO - PROCESS | 19006 | _x_x_mozilla_page_load 06:02:02 INFO - PROCESS | 19006 | _x_x_mozilla_page_load_details 06:02:02 INFO - PROCESS | 19006 | |i|pagename|runs| 06:02:02 INFO - PROCESS | 19006 | |0;ai-astar;110;104;110;111;109;110;110;109;109;110 06:02:02 INFO - PROCESS | 19006 | |1;audio-beat-detection;149;123;127;174;128;126;151;126;163;125 06:02:02 INFO - PROCESS | 19006 | |2;audio-dft;161;164;160;160;160;159;162;160;161;162 06:02:02 INFO - PROCESS | 19006 | |3;audio-fft;74;77;75;124;75;75;74;75;99;76 06:02:02 INFO - PROCESS | 19006 | |4;audio-oscillator;84;84;111;86;85;85;117;84;85;124 06:02:02 INFO - PROCESS | 19006 | |5;imaging-gaussian-blur;116;116;116;117;116;117;116;117;117;117 06:02:02 INFO - PROCESS | 19006 | |6;imaging-darkroom;147;147;146;147;147;147;147;146;147;147 06:02:02 INFO - PROCESS | 19006 | |7;imaging-desaturate;96;96;96;95;96;96;96;95;94;94 06:02:02 INFO - PROCESS | 19006 | |8;json-parse-financial;53;54;54;54;53;55;64;52;54;52 06:02:02 INFO - PROCESS | 19006 | |9;json-stringify-tinderbox;62;63;62;62;63;62;63;62;64;62 06:02:02 INFO - PROCESS | 19006 | |10;stanford-crypto-aes;79;79;80;80;80;81;80;82;111;81 06:02:02 INFO - PROCESS | 19006 | |11;stanford-crypto-ccm;134;129;132;130;119;128;121;129;124;126 06:02:02 INFO - PROCESS | 19006 | |12;stanford-crypto-pbkdf2;166;161;164;161;159;160;158;160;163;166 06:02:02 INFO - PROCESS | 19006 | |13;stanford-crypto-sha256-iterative;67;63;65;64;67;65;63;62;62;66 06:02:02 INFO - PROCESS | 19006 | __end_tp_report 06:02:02 INFO - PROCESS | 19006 | __start_cc_report 06:02:02 INFO - PROCESS | 19006 | _x_x_mozilla_cycle_collect,1647 06:02:02 INFO - PROCESS | 19006 | __end_cc_report 06:02:02 INFO - PROCESS | 19006 | __startTimestamp1465563722458__endTimestamp 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | ------- Summary: start ------- 06:02:02 INFO - PROCESS | 19006 | Number of tests: 14 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.93 (1.8%) stddev-sans-first:2.03 06:02:02 INFO - PROCESS | 19006 | Values: 110.0 104.0 110.0 111.0 109.0 110.0 110.0 109.0 109.0 110.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:138.50 stddev:18.56 (13.4%) stddev-sans-first:19.34 06:02:02 INFO - PROCESS | 19006 | Values: 149.0 123.0 127.0 174.0 128.0 126.0 151.0 126.0 163.0 125.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 06:02:02 INFO - PROCESS | 19006 | Values: 161.0 164.0 160.0 160.0 160.0 159.0 162.0 160.0 161.0 162.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.45 (21.9%) stddev-sans-first:17.17 06:02:02 INFO - PROCESS | 19006 | Values: 74.0 77.0 75.0 124.0 75.0 75.0 74.0 75.0 99.0 76.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:84.50 stddev:16.06 (19.0%) stddev-sans-first:16.58 06:02:02 INFO - PROCESS | 19006 | Values: 84.0 84.0 111.0 86.0 85.0 85.0 117.0 84.0 85.0 124.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:02:02 INFO - PROCESS | 19006 | Values: 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:02:02 INFO - PROCESS | 19006 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 06:02:02 INFO - PROCESS | 19006 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 94.0 94.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.47 (6.4%) stddev-sans-first:3.64 06:02:02 INFO - PROCESS | 19006 | Values: 53.0 54.0 54.0 54.0 53.0 55.0 64.0 52.0 54.0 52.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:02:02 INFO - PROCESS | 19006 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 63.0 62.0 64.0 62.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:80.00 stddev:9.78 (12.2%) stddev-sans-first:10.24 06:02:02 INFO - PROCESS | 19006 | Values: 79.0 79.0 80.0 80.0 80.0 81.0 80.0 82.0 111.0 81.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:129.00 stddev:4.73 (3.7%) stddev-sans-first:4.33 06:02:02 INFO - PROCESS | 19006 | Values: 134.0 129.0 132.0 130.0 119.0 128.0 121.0 129.0 124.0 126.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.00 stddev:2.82 (1.7%) stddev-sans-first:2.55 06:02:02 INFO - PROCESS | 19006 | Values: 166.0 161.0 164.0 161.0 159.0 160.0 158.0 160.0 163.0 166.0 06:02:02 INFO - PROCESS | 19006 | 06:02:02 INFO - PROCESS | 19006 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.90 (2.9%) stddev-sans-first:1.76 06:02:02 INFO - PROCESS | 19006 | Values: 67.0 63.0 65.0 64.0 67.0 65.0 63.0 62.0 62.0 66.0 06:02:02 INFO - PROCESS | 19006 | -------- Summary: end -------- 06:02:02 INFO - PROCESS | 19006 | 06:02:03 INFO - TEST-INFO | 19006: exit 0 06:02:03 INFO - TEST-OK | kraken | took 61907ms 06:02:03 INFO - SUITE-END | took 1175s 06:02:03 INFO - Completed test suite (00:19:35) 06:02:03 INFO - javascript benchmark 06:02:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.675479074696, 3096.3188098618302, 3124.8750049998002, 3147.6694947030574, 3148.748100151988, 5278.049951008817, 5335.493128152824, 5343.038253114438, 5423.050966080935, 5434.510894019542, 5344.331958505187, 5359.651622644526, 5373.650712703671, 5373.892522149565, 5407.107827208506, 4804.423469183694, 4869.4887036861155, 4909.410870695521, 4923.729194894279, 5028.798848046092, 4943.728094954776, 4951.801927922878, 4993.425756038066, 4997.100521906055, 5019.447860735316, 4787.353707249512, 4792.544708252728, 4820.373351464287, 4864.635152363587, 4894.681845680055, 4861.124997500448, 4871.902561948741, 4948.035133149037, 4952.356193694833, 4997.750112494397, 4801.15979703554, 4894.559489645913, 4913.336699545552, 4924.496020233551, 4936.185529387647, 5301.469853014706, 5380.273663055476, 5383.219433182206, 5426.75579598919, 5464.207689884945, 5753.597248192628, 5769.509591684712, 5771.50942169916, 5804.361520232771, 5806.65160090396, 5611.831645050655, 5692.48767610917, 5779.711014449261, 5814.040683287252, 5857.70711464425, 5450.482204190595, 5456.945430545684, 5470.042742520083, 5471.015217260931, 5473.8357849264985, 5960.970195149083, 5963.7912673056235, 5964.373740757244, 5964.612300200473, 5968.940310596925, 5496.972515137479, 5517.917231241535, 5584.022796010763, 5601.159826026129, 5730.19777231188, 5710.343310519261, 5755.884882302415, 5757.050086735725, 5763.682997435181, 5766.567507436959, 5669.036263835158, 5675.858103547444, 5679.517241034476, 5680.318361796611, 5681.57388195887, 5552.167174923713, 5617.915731264035, 5619.213310136584, 5639.8590035249445, 5652.406497317723, 4378.671599630041, 4384.69307148503, 4407.735535867858, 4411.09572537629, 4450.799714012877, 3897.0841852164717, 3943.684505239574, 3950.545687245946, 3965.861194858166, 3997.6801855851463, 5338.386085600206, 5343.412224655285, 5389.56883449331, 5451.536619387396, 5469.917951230735, 5673.858153546112, 5703.572232082527, 5706.315242170883, 5709.74306156224, 5731.111677689964, 5427.43011983744, 5434.864128396822, 5435.239066530688, 5437.8368648940595, 5441.0, 4866.343043689128, 4942.382202224722, 4991.825286114969, 5000.224965130411, 5009.073321435546, 5932.2584676915385, 5948.910766338508, 5972.432618901197, 5990.251218597676, 5993.130996005555, 5567.331920169606, 5769.048107062287, 5782.537397008314, 5785.566082543742, 5790.565707571865, 5937.673427961504, 5953.732082056231, 5999.040153575407, 6041.395860413923, 6060.424259695322, 5694.601377903673, 5716.79991200306, 5725.7137143141845, 5728.054870946414, 5728.312602487728, 5617.466340697627, 5718.428157184248, 5831.0378787499585, 5835.766569337179, 5838.036723940672, 5612.102063669793, 5668.631538949955, 5670.206171135962, 5670.376258611632, 5722.0, 5596.384397716167, 5640.210370548209, 5644.068728659725, 5653.349864765604, 5661.264035675335, 5439.211314359475, 5444.156155795858, 5488.9725551371985, 5561.0, 5576.693281869536, 5683.715814209356, 5687.232223649919, 5687.317521897234, 5693.060644993529, 5694.174344720075, 5480.72596370172, 5510.972445137749, 5518.613697041169, 5525.751341189576, 5527.778888844562], "value": 5306.321738571477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3591313641857, 617.428878287584, 618.3260246331498, 623.5198896849427, 638.9872202555949, 29508.704912950863, 31594.68405315949, 31661.366772664533, 31731.04806855795, 41724.0, 43689.56310436902, 44501.0, 44538.0, 44656.77671611645, 44689.776551117284, 8847.336449766277, 9097.0, 9098.454092754457, 9099.681511147111, 9100.180983711465, 8610.311175105977, 8687.869681954775, 8695.043545210021, 8695.826083478327, 8698.39111262212, 8918.554072296392, 8956.462612243253, 8965.462072275684, 8966.506842123681, 8967.282617390625, 8969.14793094655, 8992.280617550581, 9010.954945225298, 9016.323775716815, 9070.546472676373, 8872.0, 8952.0, 8963.955180224057, 8966.506842123681, 8967.10328967098, 40763.38854917179, 41265.58734412648, 41434.79282603598, 41456.79271603622, 41477.585224147675, 3238.9838050809594, 3248.025592322294, 3257.4788033914697, 3355.4128027595075, 3898.5126859142606, 27698.5845212322, 27931.58102628462, 28542.714572854213, 28744.856275718696, 29341.85329073341, 3933.3706606943038, 3985.54341966014, 4047.5750046245016, 4059.3505039193883, 4169.958300416987, 338342.0, 338656.0, 338976.0, 339191.99999999756, 339627.0, 55982.44017559854, 56186.7190664044, 56467.71766141143, 56551.15173272404, 56631.71684141635, 34739.13152171166, 35601.465978010354, 35607.4658880117, 37449.0, 59088.0, 16081.758773618405, 16263.105529196007, 16284.918575407284, 16288.755668664979, 16291.755623665655, 12233.632991010283, 12307.56923507673, 12318.630441086782, 12337.259764414164, 12364.505419783109, 19373.709394359095, 19464.416067517996, 19494.261565172357, 19513.312453006918, 19622.70565941512, 5868.483625392118, 6023.819285421444, 6153.538484613672, 6165.167702360124, 6189.412005859436, 808.8382323535199, 882.5278476015301, 888.595688961521, 919.9586018629178, 984.3552473130111, 31522.842385787924, 32293.677063229537, 32421.675783241866, 32858.671413286036, 32969.835150824096, 1065.6802959112235, 1102.443266150589, 1147.1568397228032, 1153.9423028848523, 1205.9457324420423, 16277.674446511004, 17039.91480042592, 17054.57363565896, 17103.216605296035, 17128.48614541541, 573725.0, 575095.1245243831, 577020.0, 578759.0, 586903.0, 57803.4219657798, 57981.0, 57981.4201857976, 58559.0, 58624.12063819046, 1246.875312468746, 1365.528892532075, 1378.5175188683882, 1395.413926151019, 1396.5391420831102, 28362.716372836006, 29533.26166845846, 29851.85074074616, 29944.401111978073, 29994.0, 47433.28850067183, 48429.0, 48472.27291590699, 48477.75761121172, 48526.75736621294, 394771.0, 403891.0, 404057.0, 404446.0, 404610.0, 23343.0, 24991.87504062468, 25288.873555632104, 25550.361240969123, 27256.863715681295, 46564.0, 47157.528424716686, 47503.0, 47662.0, 47713.52286477091, 37695.623043770305, 37985.4302185473, 38256.42615360828, 38312.616873830906, 38482.80758596189, 39154.4126838092, 39483.40774888321, 39485.210295794495, 39548.0, 40116.79941600273, 38465.80767096147, 39068.0, 39550.40674389829, 39724.2055158901, 39918.600813991485, 33505.0, 35206.0, 35492.82253588716, 36082.27835443224, 36217.275654486235, 27387.0, 27591.448171036067, 27832.8608356965, 27838.3040423991, 27851.683557043667], "value": 19190.61407809517, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.86352049741583, 379.69244911621587, 388.72594820651443, 395.3772807827671, 398.47600405466807, 15056.849431505681, 16773.0, 17869.285228590856, 19593.314234001813, 19613.901930490363, 16489.505314840542, 19078.90460547699, 19079.71380429291, 19173.42479725607, 19508.804911950912, 5610.635308704921, 5805.4194580542035, 5875.0, 5876.9118463223085, 5877.441643043904, 5643.6049476536655, 5754.942450575503, 5796.0, 5796.1016042513265, 5808.506276966463, 5770.913436298459, 5781.942180578203, 5788.82633520995, 5793.942060579404, 5939.762409503636, 6195.535334849882, 6273.278572964122, 6325.87348253037, 6335.176427064475, 6338.461230795388, 5461.563074953994, 5559.527440167591, 5694.629849059839, 5786.07422812348, 5798.3911689272445, 13798.65503362414, 13813.51652692151, 15895.60260993473, 20386.898065509577, 20389.490262743402, 2189.912403503858, 2314.172817415943, 2699.784017278613, 2720.3471166919994, 2903.840288784116, 10030.849537256947, 10392.376457412503, 11571.594994175248, 12481.75036499274, 14675.63310917225, 1818.3817502049235, 1960.2061165228106, 1992.6413245615784, 1994.0926878270352, 2091.0, 74010.25989740141, 75153.62423187903, 77909.0, 80792.0, 83676.58161709213, 10037.648682296085, 10161.491925403849, 10288.890777390618, 10360.430176340373, 10554.261201715806, 14143.929280353532, 14183.432662693376, 14220.0, 14512.637184070483, 14691.265436728121, 7639.312461878458, 7792.376609871197, 7894.565798881116, 7962.84074318522, 7972.840543189103, 7435.293647103516, 7447.255274472509, 7554.2823431773895, 7604.353629941406, 7648.80877978055, 4393.406890069864, 4708.8351907683755, 4740.66815322931, 4834.758262086882, 4848.660593758474, 1826.8264514871066, 1828.232142500153, 1830.4508647405726, 1885.77370715515, 1885.86798924074, 952.7570469530225, 967.2503809547517, 995.4674249276748, 1016.3393794033938, 1042.0257059649252, 17967.06371412581, 18350.265989360276, 18490.907545462185, 18520.536986575444, 18602.25590976346, 953.6709835106877, 958.496789185683, 963.9855402168973, 1017.4353233955078, 1070.641335152717, 9646.710598682052, 10121.797564048678, 10158.288919775545, 10479.895201048044, 10625.203109766644, 452592.0, 465951.3834031653, 468892.0, 470670.0, 471309.0, 54170.45829541733, 67726.66136669384, 90255.54872225598, 93515.53242233745, 95294.0, 944.5843828715481, 948.8481842905102, 979.3340528440729, 979.6424305128719, 985.7239972807625, 16401.140532780213, 16670.083145426634, 16720.331186752395, 17013.48959531216, 17307.913460432617, 40295.194096117324, 40449.79775101106, 40635.390469143575, 41993.16013679648, 42273.577264226966, 57176.42823571711, 57308.71345643245, 57382.98319117789, 57741.71129144495, 57957.0, 6984.720611175496, 7391.926080739124, 8152.714654987047, 8428.536430496137, 8706.434081784664, 12573.434195461408, 12888.226706397647, 13080.476780928657, 13250.867491325349, 13377.398017089448, 11314.377709226072, 11366.715832104264, 11562.653120406401, 11705.122115841516, 11712.648620541397, 11032.172587056164, 11466.197366184288, 11523.366214858263, 11592.942035289769, 11724.41377931083, 11620.88379116198, 11639.6508104757, 11758.70603234926, 12080.154389192672, 12188.146829722189, 7630.580318082559, 7719.498232614862, 7827.491213071132, 7873.409494287836, 7911.762647120596, 10727.731806704895, 11990.820137698116, 12020.519179233082, 12117.091218158497, 12119.030477561597], "value": 8986.39692062373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.8957138643216, 1402.2287741742043, 1447.5584946591289, 1514.9772753408695, 1716.8540674042706, 8686.565671716413, 8868.201861832435, 8941.597628106734, 9226.261899048077, 9246.491442970633, 8771.56142192891, 8964.520854059088, 8965.013848476663, 9001.414908030973, 9036.09639036096, 2055.239561362298, 2280.144945645383, 2360.2329242996093, 2397.928062158134, 2428.805695544352, 2364.76352364763, 2414.6860908081926, 2415.492746523232, 2415.855048697075, 2416.9395765105924, 2378.5480758655885, 2398.9280321590295, 2406.74729153439, 2409.518096380722, 2412.1316326122583, 2011.6982452632076, 2204.680321353411, 2281.418238349227, 2284.4745708486976, 2307.2501437032947, 2353.5881220786296, 2369.5379401016808, 2374.382660508263, 2377.4531857672832, 2381.3213234228333, 8989.280857531447, 9045.547722613843, 9053.818923621557, 9055.547222638841, 9065.22945549629, 5206.687598744087, 5319.813806516792, 5331.306930099101, 5332.173513105436, 5348.304720386325, 3318.0875259303643, 3462.3940810358085, 3509.929801403983, 3546.184377593168, 3552.5381700379044, 1107.7119948813286, 1150.068444559909, 1187.994060029703, 1203.7472130852532, 1213.0, 12780.233186008776, 12923.483060677561, 12968.286744229064, 12968.481260749559, 13000.414981325863, 4522.819087236474, 4621.12198682256, 4668.8599342019115, 4677.929831052537, 4685.648576356787, 10895.509702063426, 10926.344419334866, 10935.83596246057, 10936.890631093745, 10940.0, 5309.442508536626, 5417.945820541744, 5420.728963551806, 5421.0, 5428.212909128154, 4364.410804541346, 4768.332433459249, 4926.581240594518, 4930.433000204951, 5008.874778130576, 3829.5787463379006, 3938.940915886264, 3949.881503554898, 4016.357382818735, 4096.713230073866, 1212.6968257935516, 1217.4156404925686, 1220.7619514194823, 1236.097648716442, 1243.9937800311122, 855.2089317381398, 958.8705524754068, 972.5040229483014, 976.6435251133428, 1006.1598565198142, 6259.624422534663, 6330.3669633036325, 6381.329960354189, 6409.583377080475, 6473.676316184266, 407.6392392732394, 410.21239220695736, 416.5792549524941, 458.5368777534714, 459.91261660284437, 4265.232258193555, 4328.654112171465, 4382.276924307517, 4399.868003959887, 4404.185225733249, 11135.0, 11535.250208736405, 11650.126240531994, 11664.591739289084, 11673.941630291794, 11299.209055366046, 11449.885501144881, 11489.0, 11510.482028308747, 11510.712232194095, 7855.607219638995, 8117.878231826528, 8228.958855205685, 8390.244877960891, 8506.36202284831, 6276.937230627818, 6587.901181482377, 6618.867622647424, 6639.136912201383, 6678.0, 10464.476776161313, 10678.359298441808, 10799.298045627009, 10817.972292632187, 10833.02502774754, 10675.412852293199, 10771.622993195515, 10799.730006749895, 10936.50785714629, 10955.671329860117, 7327.4504412168235, 7938.0, 8109.7161599343735, 8142.918570814216, 8286.958565207135, 8921.821563568563, 8941.687040953535, 9006.86489702668, 9035.864462033207, 9040.141186587263, 7868.095169055403, 8024.0772311184965, 8129.959350203448, 8134.593270336341, 8191.262786349019, 7691.269329413697, 7875.094364147967, 7946.483478573874, 8028.518288902451, 8074.515529068275, 7195.352418282379, 7256.492045556972, 7351.558906465629, 7357.411407087313, 7366.668499917624, 5320.0, 5411.567074634098, 5429.918551221814, 5458.61789674719, 5459.153831156177, 5455.9454405455435, 5467.234587157881, 5555.666660000251, 5658.009848276617, 5670.177824215548], "value": 4672.14864342883, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.290854939211, 331.7196968561566, 333.726344397594, 337.7450025230951, 337.79563364164693, 5206.895862082756, 5280.947190528093, 5329.600279979008, 5331.386890507592, 5382.38102618199, 5283.973580132104, 5299.224759705503, 5308.283381743464, 5334.413214546406, 5340.599455040878, 4169.457970463851, 4169.687273454488, 4173.791310434482, 4185.183889141618, 4201.7478951262865, 4051.5948405159397, 4125.2986992211245, 4142.150859073898, 4145.937810932838, 4205.747655140686, 4111.753294802322, 4121.876343709693, 4138.8344466221315, 4144.440500532435, 4164.687648426365, 4114.526829414611, 4170.895727606834, 4179.393987871742, 4183.97908010461, 4184.309588917825, 3709.2210635766523, 3709.239605880788, 3711.7751142123034, 3714.9442758358377, 3723.3111874303067, 4944.728039957801, 5168.689878607295, 5174.7412629368755, 5181.041507321158, 5217.399999000126, 4698.154332220199, 4703.529647035303, 4723.574878260939, 4726.858194254178, 4753.405824271966, 5247.47525247476, 5452.672839629635, 5515.669059856422, 5557.666540007572, 5565.9443405566235, 3915.1973845361917, 3917.902052448683, 3932.1742434088874, 3939.566647668783, 3947.782871942042, 5421.756020979065, 5488.396276409631, 5666.971665141689, 5703.201551782754, 5708.372079071299, 3972.3445631470486, 3977.5823538528616, 3981.343078392033, 3984.242993831163, 3988.202359528106, 4010.9197816043516, 4036.192761447722, 4057.5333836609166, 4065.288574499451, 4094.2630326541507, 4434.733915965053, 4524.140413321458, 4677.625789936865, 4685.695429797121, 4727.810887564528, 5416.7020813855615, 5457.5633949283965, 5470.72646367688, 5546.91679624806, 5573.554115670737, 1368.4594585139014, 1379.9724005519834, 1388.7361401333715, 1389.305347326337, 1397.3292819446722, 848.4739461533889, 878.3149143667949, 890.8930928288647, 905.2622112977901, 905.542700936023, 4693.741844198534, 4769.379980602499, 4796.112719146969, 4796.232602783538, 4796.937316953743, 4930.7288099154175, 5029.1450453423, 5045.772940217699, 5089.9745501272255, 5106.693598384109, 4662.018642077103, 4795.44148151852, 4804.654696684934, 4834.694632449289, 5060.822871199564, 3046.573479712842, 3057.9541306880415, 3077.2306923269184, 3079.6766339534474, 3085.182426656938, 5773.595848290579, 5792.4497172768515, 5833.38749431312, 5879.647221166743, 5881.088646190005, 5571.0, 5740.655560666373, 5762.222100016528, 5784.0, 5821.592488525763, 5836.358000619928, 5880.500157486662, 5883.411478900673, 5883.823485295448, 5886.852828679317, 5371.543418809445, 5636.633618814764, 5643.266375371176, 5721.713914304351, 5736.799212027726, 5550.222968784293, 5590.217369568182, 5592.916106258491, 5666.291713535808, 5691.573132015033, 5544.473275038865, 5703.914441283301, 5852.600433822113, 5865.3254875688135, 5870.324912635102, 4074.8166332514515, 4105.58944105587, 4109.602735069971, 4129.834806607702, 4131.967008247938, 5473.589480788877, 5679.318481782213, 5727.713614319184, 5729.656220626775, 5748.367679555329, 5503.972480137734, 5540.695261760642, 5551.500364967173, 5574.331080270394, 5594.720263986866, 5494.450554944474, 5516.613837031369, 5545.72271386421, 5556.944430555643, 5572.829705761836, 5199.63602547818, 5438.75525601341, 5462.481064298885, 5526.778928842962, 5549.223108764695, 5501.422350653123, 5546.278983732089, 5574.832755017356, 5575.661841158012, 5607.710226647975, 5420.214068960057, 5422.912178811107, 5492.313460817398, 5513.731841676356, 5560.944390556205], "value": 4179.818088394368, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.2705067881438, 786.0919153317625, 801.5591424716405, 822.5106061893175, 842.5997651115721, 11999.940000300008, 14726.926365368172, 15890.126043067627, 15908.443204487845, 16028.519144425656, 14301.928490357534, 14847.925760371183, 14875.702485950302, 14920.850791492081, 15037.77443338348, 815.922487363701, 823.2508417340222, 824.171707434028, 826.5784449930549, 829.3696790439279, 639.7600899662626, 796.7052190689453, 810.3719617296583, 813.0690359538326, 818.7175424478545, 860.5869182792263, 861.7371701631, 864.7276108025983, 866.0386970462781, 866.7183165471215, 856.0113069404847, 858.4849090545686, 858.6994551906845, 858.7337925243132, 858.8883445152121, 624.1418050181001, 624.9312575616678, 626.0890404461497, 626.2234828812285, 626.2891618013542, 13352.33238338089, 13399.330033498383, 13401.396937137852, 13403.0, 13436.0, 14387.0, 14692.338844751905, 14748.336324865406, 15015.0, 15197.696046079016, 11157.832632510519, 11266.830997535044, 11554.480048397842, 11753.823692644617, 11909.523619055228, 3812.370958791796, 3858.401947698111, 3920.607939206085, 4049.271131196413, 4095.28332541804, 69647.65176174087, 71066.289337107, 73733.63133184353, 74773.626131869, 75194.24805751981, 11452.255603385753, 11492.965633093061, 11605.361705106301, 11736.0, 11941.283522988648, 21950.560988780137, 21973.0, 21981.67027494589, 21983.120675173133, 22024.889875550518, 8087.595620218965, 8218.424710270223, 8381.706640267561, 8538.01812791537, 8592.613332399931, 4642.094791515689, 4695.81216751333, 4746.454157771831, 4749.073930583503, 4870.220764677634, 3565.8217089145437, 3691.0956815579816, 3692.2800053989213, 3696.1868388954385, 3705.0366904605, 532.5659587436227, 616.2881871438495, 624.6751689121722, 625.8278973282384, 626.6616027345274, 663.9535232533676, 730.5908691132983, 741.7403908632043, 743.9367653749492, 763.3587786259569, 8597.699080532151, 8637.179467950535, 8849.159329863653, 8876.423032502867, 8959.1936725695, 681.271039987209, 729.6497681113095, 737.9188289288174, 744.2148533297315, 748.8839229919371, 4463.709858859163, 4596.540345965377, 4607.95392046082, 4616.192166370872, 4618.769061546909, 65844.67077664581, 91948.54025729962, 103894.0, 107018.0, 108908.4554577222, 88428.0, 92477.53761231151, 92541.0, 92638.53680731553, 93952.0, 59074.704626476596, 75617.0, 77434.0, 85583.0, 86839.69740453898, 9042.140996605312, 9349.4635471817, 9566.186874115778, 9730.318877678494, 9760.46317452547, 38764.0, 48908.0, 49643.75178124086, 49666.0, 51762.0, 66519.35248417675, 66884.6655766718, 75421.62289188518, 76800.0, 76873.61563192148, 12716.809247861105, 12905.096643234883, 12934.353282335658, 13195.472181112647, 13203.0, 13072.803907941197, 13204.607919986292, 13501.459941602227, 13552.119112257671, 13638.79541806854, 12242.75514489723, 12599.748005039664, 12649.24104553693, 12734.108612397044, 13037.674058148623, 12558.686032849251, 12863.935680321538, 13261.933690331873, 13433.798493022417, 13624.591262262147, 12562.811557826457, 13021.47914083464, 13042.739145217232, 13370.264635444755, 13497.122687025312, 10449.477526123816, 10514.842277365693, 10594.629187978384, 10754.569817207224, 10945.288556243819, 9948.502574871372, 10159.593616255563, 10232.618596489676, 10236.53935572886, 10774.730631733955], "value": 7349.484484776205, "unit": "score"}], "name": "dromaeo_css", "value": 7129.740171969573, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 111.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 127.0, 174.0, 128.0, 126.0, 151.0, 126.0, 163.0, 125.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 160.0, 160.0, 160.0, 159.0, 162.0, 160.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 124.0, 75.0, 75.0, 74.0, 75.0, 99.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 86.0, 85.0, 85.0, 117.0, 84.0, 85.0, 124.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 53.0, 55.0, 64.0, 52.0, 54.0, 52.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 64.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 80.0, 81.0, 80.0, 82.0, 111.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 132.0, 130.0, 119.0, 128.0, 121.0, 129.0, 124.0, 126.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 164.0, 161.0, 159.0, 160.0, 158.0, 160.0, 163.0, 166.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 65.0, 64.0, 67.0, 65.0, 63.0, 62.0, 62.0, 66.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1498.6000000000001, "alertThreshold": 2.0}]} 06:02:03 INFO - Return code: 0 06:02:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:02:03 ERROR - # TBPL SUCCESS # 06:02:03 INFO - Running post-action listener: _resource_record_post_action 06:02:03 INFO - ##### 06:02:03 INFO - ##### Finished run-tests step (success) 06:02:03 INFO - ##### 06:02:03 INFO - Running post-run listener: _resource_record_post_run 06:02:03 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 312086528; Read time: 12; Write time: 232560 06:02:03 INFO - TinderboxPrint: CPU usage
13.2% 06:02:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:02:03 INFO - TinderboxPrint: I/O write bytes / time
312,086,528 / 232,560 06:02:03 INFO - TinderboxPrint: CPU idle
8,273.4 (86.8%) 06:02:03 INFO - TinderboxPrint: CPU user
1,206.2 (12.7%) 06:02:03 INFO - TinderboxPrint: Swap in / out
0 / 0 06:02:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 18944000; Read time: 0; Write time: 3968 06:02:03 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293142528; Read time: 12; Write time: 228592 06:02:04 INFO - Running post-run listener: _upload_blobber_files 06:02:04 INFO - Blob upload gear active. 06:02:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:02: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 06:02: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:02: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:02:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:02:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:02:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:02:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:05 INFO - (blobuploader) - INFO - Done attempting. 06:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:02:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:10 INFO - (blobuploader) - INFO - Done attempting. 06:02:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:02:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:02:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:02:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:11 INFO - (blobuploader) - INFO - Done attempting. 06:02:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:11 INFO - Return code: 0 06:02:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3163d829f84172e223bb26723032286c1fe867d7f370a2ffb35841fb8e259aeb355e8c0d286954b5e711f1ef5086809522ca05d9fa43be9f7b64c477c6d9eeb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aff6a7abc412bd68570d9b5157e5db670f86993e0a2e9acee17bec7723b81e630fa09b1a5a7877f46ecf21938091ae9d71349b491ada83190aa5742f5aa896a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b918f8a11e9d131cf8385eba2863b2ded44155ac447d3a5976f2bb86699bbc0bb587f3ee9375a1303dd60b33b18a049d2c6410d873abb8c21f8c83a7bd5f69f"} 06:02:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:11 INFO - Contents: 06:02:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3163d829f84172e223bb26723032286c1fe867d7f370a2ffb35841fb8e259aeb355e8c0d286954b5e711f1ef5086809522ca05d9fa43be9f7b64c477c6d9eeb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aff6a7abc412bd68570d9b5157e5db670f86993e0a2e9acee17bec7723b81e630fa09b1a5a7877f46ecf21938091ae9d71349b491ada83190aa5742f5aa896a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b918f8a11e9d131cf8385eba2863b2ded44155ac447d3a5976f2bb86699bbc0bb587f3ee9375a1303dd60b33b18a049d2c6410d873abb8c21f8c83a7bd5f69f"} 06:02:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:11 INFO - Copying logs to upload dir... 06:02:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.496675 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-10 06:02:11.531923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:11.535972) ========= 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=eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3163d829f84172e223bb26723032286c1fe867d7f370a2ffb35841fb8e259aeb355e8c0d286954b5e711f1ef5086809522ca05d9fa43be9f7b64c477c6d9eeb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aff6a7abc412bd68570d9b5157e5db670f86993e0a2e9acee17bec7723b81e630fa09b1a5a7877f46ecf21938091ae9d71349b491ada83190aa5742f5aa896a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b918f8a11e9d131cf8385eba2863b2ded44155ac447d3a5976f2bb86699bbc0bb587f3ee9375a1303dd60b33b18a049d2c6410d873abb8c21f8c83a7bd5f69f"} build_url:https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/RjQVGoMPQ46asYMTyVDS4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3163d829f84172e223bb26723032286c1fe867d7f370a2ffb35841fb8e259aeb355e8c0d286954b5e711f1ef5086809522ca05d9fa43be9f7b64c477c6d9eeb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3aff6a7abc412bd68570d9b5157e5db670f86993e0a2e9acee17bec7723b81e630fa09b1a5a7877f46ecf21938091ae9d71349b491ada83190aa5742f5aa896a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b918f8a11e9d131cf8385eba2863b2ded44155ac447d3a5976f2bb86699bbc0bb587f3ee9375a1303dd60b33b18a049d2c6410d873abb8c21f8c83a7bd5f69f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:11.561886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:11.562603) ========= 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=eca2ab57546de7b41f256b19000001ef-1465561517.105896-1531625652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 06:02:11.647231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 06:02:11.647603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 06:02:11.647932) ========= ========= Total master_lag: 0.17 =========