builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1466066245.4 results: success (0) buildid: 20160615235725 builduid: 8a941b4d6ef8401daa74fa1a459110e2 revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.403689) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.404420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.404778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.425209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.425579) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 01:37:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-16 01:37:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126431 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.570622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.571066) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016279 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.623316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:25.624341) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c914e1312fd6cede0da6dcaa1c605eaf07849138 --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 c914e1312fd6cede0da6dcaa1c605eaf07849138 --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=9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 01:37:26,022 truncating revision to first 12 chars 2016-06-16 01:37:26,022 Setting DEBUG logging. 2016-06-16 01:37:26,022 attempt 1/10 2016-06-16 01:37:26,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c914e1312fd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 01:37:26,346 unpacking tar archive at: mozilla-central-c914e1312fd6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677396 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:26.332538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:26.332855) ========= script_repo_revision: c914e1312fd6cede0da6dcaa1c605eaf07849138 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:26.333317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:26.333657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:37:26.344410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-16 01:37:26.344734) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:37:26 INFO - MultiFileLogger online at 20160616 01:37:26 in /builds/slave/test 01:37:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 01:37:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:26 INFO - {'append_to_log': False, 01:37:26 INFO - 'base_work_dir': '/builds/slave/test', 01:37:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:37:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:26 INFO - 'branch': 'Firefox-Non-PGO', 01:37:26 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:26 INFO - 'config_files': ('talos/linux_config.py',), 01:37:26 INFO - 'default_actions': ('clobber', 01:37:26 INFO - 'read-buildbot-config', 01:37:26 INFO - 'download-and-extract', 01:37:26 INFO - 'populate-webroot', 01:37:26 INFO - 'create-virtualenv', 01:37:26 INFO - 'install', 01:37:26 INFO - 'run-tests'), 01:37:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:26 INFO - 'download_minidump_stackwalk': True, 01:37:26 INFO - 'download_symbols': 'ondemand', 01:37:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:26 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:26 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:26 INFO - 'installer_path': 'installer.exe', 01:37:26 INFO - 'log_level': 'info', 01:37:26 INFO - 'log_name': 'talos', 01:37:26 INFO - 'log_to_console': True, 01:37:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:37:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:37:26 INFO - 'opt_config_files': (), 01:37:26 INFO - 'pip_index': False, 01:37:26 INFO - 'sps_profile': False, 01:37:26 INFO - 'sps_profile_interval': 0, 01:37:26 INFO - 'suite': 'dromaeojs', 01:37:26 INFO - 'system_bits': '32', 01:37:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:26 INFO - 'title': 'talos-linux64-ix-013', 01:37:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:26 INFO - 'use_talos_json': True, 01:37:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:26 INFO - 'work_dir': 'build'} 01:37:26 INFO - ##### 01:37:26 INFO - ##### Running clobber step. 01:37:26 INFO - ##### 01:37:26 INFO - Running pre-action listener: _resource_record_pre_action 01:37:26 INFO - Running main action method: clobber 01:37:26 INFO - rmtree: /builds/slave/test/build 01:37:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:27 INFO - Running post-action listener: _resource_record_post_action 01:37:27 INFO - ##### 01:37:27 INFO - ##### Finished clobber step (success) 01:37:27 INFO - ##### 01:37:27 INFO - ##### 01:37:27 INFO - ##### Running read-buildbot-config step. 01:37:27 INFO - ##### 01:37:27 INFO - Running pre-action listener: _resource_record_pre_action 01:37:27 INFO - Running main action method: read_buildbot_config 01:37:27 INFO - Using buildbot properties: 01:37:27 INFO - { 01:37:27 INFO - "project": "", 01:37:27 INFO - "product": "firefox", 01:37:27 INFO - "script_repo_revision": "production", 01:37:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:37:27 INFO - "repository": "", 01:37:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 01:37:27 INFO - "buildid": "20160615235725", 01:37:27 INFO - "pgo_build": "False", 01:37:27 INFO - "basedir": "/builds/slave/test", 01:37:27 INFO - "buildnumber": 116, 01:37:27 INFO - "slavename": "talos-linux64-ix-013", 01:37:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:37:27 INFO - "platform": "ubuntu64_hw", 01:37:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 01:37:27 INFO - "branch": "mozilla-central", 01:37:27 INFO - "repo_path": "mozilla-central", 01:37:27 INFO - "revision": "c914e1312fd6cede0da6dcaa1c605eaf07849138", 01:37:27 INFO - "stage_platform": "linux64", 01:37:27 INFO - "builduid": "8a941b4d6ef8401daa74fa1a459110e2", 01:37:27 INFO - "slavebuilddir": "test" 01:37:27 INFO - } 01:37:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:37:27 INFO - Running post-action listener: _resource_record_post_action 01:37:27 INFO - ##### 01:37:27 INFO - ##### Finished read-buildbot-config step (success) 01:37:27 INFO - ##### 01:37:27 INFO - ##### 01:37:27 INFO - ##### Running download-and-extract step. 01:37:27 INFO - ##### 01:37:27 INFO - Running pre-action listener: _resource_record_pre_action 01:37:27 INFO - Running main action method: download_and_extract 01:37:27 INFO - mkdir: /builds/slave/test/build/tests 01:37: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')]} 01:37:27 INFO - https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:37:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:37:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:37:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:27 INFO - Downloaded 1361 bytes. 01:37:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:37:27 INFO - Using the following test package requirements: 01:37:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:37:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:37:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:37:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'jsshell-linux-x86_64.zip'], 01:37:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:37:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:37:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:37:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:37:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:37:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:37:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:37:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:37: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')]} 01:37:27 INFO - https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:37:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:37:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:37:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:29 INFO - Downloaded 22654271 bytes. 01:37: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'] 01:37: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 01:37:30 INFO - Return code: 0 01:37: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 01:37: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')]} 01:37:30 INFO - https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:31 INFO - Downloaded 22654271 bytes. 01:37:31 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'] 01:37:31 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 01:37:32 INFO - Return code: 0 01:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:32 INFO - https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:37:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:37:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:37:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:34 INFO - Downloaded 14405384 bytes. 01:37:34 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'] 01:37:34 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 01:37:34 INFO - Return code: 0 01:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:34 INFO - https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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 01:37:36 INFO - Downloaded 55436043 bytes. 01:37:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:37:36 INFO - mkdir: /builds/slave/test/properties 01:37:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:36 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:36 INFO - Contents: 01:37:36 INFO - build_url:https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:37:37 INFO - Running post-action listener: _resource_record_post_action 01:37:37 INFO - Running post-action listener: set_extra_try_arguments 01:37:37 INFO - ##### 01:37:37 INFO - ##### Finished download-and-extract step (success) 01:37:37 INFO - ##### 01:37:37 INFO - ##### 01:37:37 INFO - ##### Running populate-webroot step. 01:37:37 INFO - ##### 01:37:37 INFO - Running pre-action listener: _resource_record_pre_action 01:37:37 INFO - Running main action method: populate_webroot 01:37:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:37 INFO - '--tppagecycles', 01:37:37 INFO - '7'], 01:37:37 INFO - 'tests': ['tsvgm']}}, 01:37:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['damp', 'tps']}, 01:37:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'tests': ['damp', 'tps']}, 01:37:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['dromaeo_dom']}, 01:37:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['basic_compositor_video']}, 01:37:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:37:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['a11yr', 01:37:37 INFO - 'ts_paint', 01:37:37 INFO - 'tpaint', 01:37:37 INFO - 'sessionrestore', 01:37:37 INFO - 'sessionrestore_no_auto_restore', 01:37:37 INFO - 'tabpaint']}, 01:37:37 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:37 INFO - 'ts_paint', 01:37:37 INFO - 'tpaint', 01:37:37 INFO - 'sessionrestore', 01:37:37 INFO - 'sessionrestore_no_auto_restore', 01:37:37 INFO - 'tabpaint']}, 01:37:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:37 INFO - 'ts_paint', 01:37:37 INFO - 'tpaint', 01:37:37 INFO - 'sessionrestore', 01:37:37 INFO - 'sessionrestore_no_auto_restore', 01:37:37 INFO - 'tabpaint']}, 01:37:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:37 INFO - 'ts_paint', 01:37:37 INFO - 'tpaint', 01:37:37 INFO - 'sessionrestore', 01:37:37 INFO - 'sessionrestore_no_auto_restore', 01:37:37 INFO - 'tabpaint']}, 01:37:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['a11yr', 01:37:37 INFO - 'ts_paint', 01:37:37 INFO - 'tpaint', 01:37:37 INFO - 'sessionrestore', 01:37:37 INFO - 'sessionrestore_no_auto_restore', 01:37:37 INFO - 'tabpaint']}, 01:37:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['a11yr', 01:37:37 INFO - 'ts_paint', 01:37:37 INFO - 'tpaint', 01:37:37 INFO - 'sessionrestore', 01:37:37 INFO - 'sessionrestore_no_auto_restore', 01:37:37 INFO - 'tabpaint']}, 01:37:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['tsvgx', 01:37:37 INFO - 'tsvgr_opacity', 01:37:37 INFO - 'tart', 01:37:37 INFO - 'tscrollx', 01:37:37 INFO - 'cart']}, 01:37:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:37 INFO - 'tsvgr_opacity', 01:37:37 INFO - 'tart', 01:37:37 INFO - 'tscrollx', 01:37:37 INFO - 'cart']}, 01:37:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'talos_options': ['--disable-e10s'], 01:37:37 INFO - 'tests': ['tp5o']}, 01:37:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'tests': ['tp5o']}, 01:37:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'talos_options': ['--disable-e10s', 01:37:37 INFO - '--xperf_path', 01:37:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:37 INFO - 'tests': ['tp5n']}, 01:37:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:37 INFO - 'talos_options': ['--xperf_path', 01:37:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:37 INFO - 'tests': ['tp5n']}}, 01:37:37 INFO - 'talos.zip': {'path': '', 01:37:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:37 INFO - Running post-action listener: _resource_record_post_action 01:37:37 INFO - ##### 01:37:37 INFO - ##### Finished populate-webroot step (success) 01:37:37 INFO - ##### 01:37:37 INFO - ##### 01:37:37 INFO - ##### Running create-virtualenv step. 01:37:37 INFO - ##### 01:37:37 INFO - Running pre-action listener: _resource_record_pre_action 01:37:37 INFO - Running main action method: create_virtualenv 01:37:37 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37:37 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 01:37:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:37 INFO - Using real prefix '/usr' 01:37:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:38 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:40 INFO - Installing pip.................done. 01:37:40 INFO - Return code: 0 01:37:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37:40 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')]} 01:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:40 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')]} 01:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:40 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:40 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 01:37:40 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 01:37:40 INFO - Using env: {'DISPLAY': ':0', 01:37:40 INFO - 'HOME': '/home/cltbld', 01:37:40 INFO - 'LANG': 'en_US.UTF-8', 01:37:40 INFO - 'LANGUAGE': 'en_US:en', 01:37:40 INFO - 'LOGNAME': 'cltbld', 01:37:40 INFO - 'MAIL': '/var/mail/cltbld', 01:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:40 INFO - 'MOZ_NO_REMOTE': '1', 01:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:40 INFO - 'NO_EM_RESTART': '1', 01:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:40 INFO - 'PWD': '/builds/slave/test', 01:37:40 INFO - 'SHELL': '/bin/bash', 01:37:40 INFO - 'SHLVL': '1', 01:37:40 INFO - 'TERM': 'linux', 01:37:40 INFO - 'TMOUT': '86400', 01:37:40 INFO - 'USER': 'cltbld', 01:37:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:40 INFO - '_': '/tools/buildbot/bin/python'} 01:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:40 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 01:37:40 INFO - Cleaning up... 01:37:40 INFO - Return code: 0 01:37:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:37:40 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')]} 01:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:40 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')]} 01:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:40 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:40 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 01:37:40 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 01:37:40 INFO - Using env: {'DISPLAY': ':0', 01:37:40 INFO - 'HOME': '/home/cltbld', 01:37:40 INFO - 'LANG': 'en_US.UTF-8', 01:37:40 INFO - 'LANGUAGE': 'en_US:en', 01:37:40 INFO - 'LOGNAME': 'cltbld', 01:37:40 INFO - 'MAIL': '/var/mail/cltbld', 01:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:40 INFO - 'MOZ_NO_REMOTE': '1', 01:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:40 INFO - 'NO_EM_RESTART': '1', 01:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:40 INFO - 'PWD': '/builds/slave/test', 01:37:40 INFO - 'SHELL': '/bin/bash', 01:37:40 INFO - 'SHLVL': '1', 01:37:40 INFO - 'TERM': 'linux', 01:37:40 INFO - 'TMOUT': '86400', 01:37:40 INFO - 'USER': 'cltbld', 01:37:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:40 INFO - '_': '/tools/buildbot/bin/python'} 01:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:40 INFO - Downloading/unpacking psutil>=3.1.1 01:37:40 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 01:37:40 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 01:37:40 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 01:37:40 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 01:37:40 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 01:37:40 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 01:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:42 INFO - Installing collected packages: psutil 01:37:42 INFO - Running setup.py install for psutil 01:37:42 INFO - building 'psutil._psutil_linux' extension 01:37:42 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 01:37:42 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 01:37:42 INFO - building 'psutil._psutil_posix' extension 01:37:43 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 01:37:43 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 01:37:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:43 INFO - Successfully installed psutil 01:37:43 INFO - Cleaning up... 01:37:43 INFO - Return code: 0 01:37:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:37:43 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')]} 01:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:43 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')]} 01:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:43 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:43 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 01:37:43 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 01:37:43 INFO - Using env: {'DISPLAY': ':0', 01:37:43 INFO - 'HOME': '/home/cltbld', 01:37:43 INFO - 'LANG': 'en_US.UTF-8', 01:37:43 INFO - 'LANGUAGE': 'en_US:en', 01:37:43 INFO - 'LOGNAME': 'cltbld', 01:37:43 INFO - 'MAIL': '/var/mail/cltbld', 01:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:43 INFO - 'MOZ_NO_REMOTE': '1', 01:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:43 INFO - 'NO_EM_RESTART': '1', 01:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:43 INFO - 'PWD': '/builds/slave/test', 01:37:43 INFO - 'SHELL': '/bin/bash', 01:37:43 INFO - 'SHLVL': '1', 01:37:43 INFO - 'TERM': 'linux', 01:37:43 INFO - 'TMOUT': '86400', 01:37:43 INFO - 'USER': 'cltbld', 01:37:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:43 INFO - '_': '/tools/buildbot/bin/python'} 01:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:37:45 INFO - Installing collected packages: mozsystemmonitor 01:37:45 INFO - Running setup.py install for mozsystemmonitor 01:37:45 INFO - Successfully installed mozsystemmonitor 01:37:45 INFO - Cleaning up... 01:37:45 INFO - Return code: 0 01:37:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:37:45 INFO - Using env: {'DISPLAY': ':0', 01:37:45 INFO - 'HOME': '/home/cltbld', 01:37:45 INFO - 'LANG': 'en_US.UTF-8', 01:37:45 INFO - 'LANGUAGE': 'en_US:en', 01:37:45 INFO - 'LOGNAME': 'cltbld', 01:37:45 INFO - 'MAIL': '/var/mail/cltbld', 01:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:45 INFO - 'MOZ_NO_REMOTE': '1', 01:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:45 INFO - 'NO_EM_RESTART': '1', 01:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:45 INFO - 'PWD': '/builds/slave/test', 01:37:45 INFO - 'SHELL': '/bin/bash', 01:37:45 INFO - 'SHLVL': '1', 01:37:45 INFO - 'TERM': 'linux', 01:37:45 INFO - 'TMOUT': '86400', 01:37:45 INFO - 'USER': 'cltbld', 01:37:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:45 INFO - '_': '/tools/buildbot/bin/python'} 01:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:45 INFO - Downloading/unpacking jsonschema==2.5.1 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:45 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 01:37:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:37:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:47 INFO - Downloading functools32-3.2.3-2.tar.gz 01:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:37:47 INFO - warning: no files found matching '*.txt' 01:37:47 INFO - no previously-included directories found matching 'build' 01:37:47 INFO - no previously-included directories found matching 'dist' 01:37:47 INFO - no previously-included directories found matching '.git*' 01:37:47 INFO - Installing collected packages: jsonschema, functools32 01:37:47 INFO - Running setup.py install for functools32 01:37:48 INFO - warning: no files found matching '*.txt' 01:37:48 INFO - no previously-included directories found matching 'build' 01:37:48 INFO - no previously-included directories found matching 'dist' 01:37:48 INFO - no previously-included directories found matching '.git*' 01:37:48 INFO - Successfully installed jsonschema functools32 01:37:48 INFO - Cleaning up... 01:37:48 INFO - Return code: 0 01:37:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:37:48 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')]} 01:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:48 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')]} 01:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:48 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:48 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 01:37:48 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 01:37:48 INFO - Using env: {'DISPLAY': ':0', 01:37:48 INFO - 'HOME': '/home/cltbld', 01:37:48 INFO - 'LANG': 'en_US.UTF-8', 01:37:48 INFO - 'LANGUAGE': 'en_US:en', 01:37:48 INFO - 'LOGNAME': 'cltbld', 01:37:48 INFO - 'MAIL': '/var/mail/cltbld', 01:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:48 INFO - 'MOZ_NO_REMOTE': '1', 01:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:48 INFO - 'NO_EM_RESTART': '1', 01:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:48 INFO - 'PWD': '/builds/slave/test', 01:37:48 INFO - 'SHELL': '/bin/bash', 01:37:48 INFO - 'SHLVL': '1', 01:37:48 INFO - 'TERM': 'linux', 01:37:48 INFO - 'TMOUT': '86400', 01:37:48 INFO - 'USER': 'cltbld', 01:37:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:48 INFO - '_': '/tools/buildbot/bin/python'} 01:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:48 INFO - Downloading/unpacking blobuploader==1.2.4 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:50 INFO - Downloading blobuploader-1.2.4.tar.gz 01:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:37:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:37:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:50 INFO - Downloading docopt-0.6.1.tar.gz 01:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:37:50 INFO - Installing collected packages: blobuploader, requests, docopt 01:37:50 INFO - Running setup.py install for blobuploader 01:37:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:37:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:37:51 INFO - Running setup.py install for requests 01:37:51 INFO - Running setup.py install for docopt 01:37:51 INFO - Successfully installed blobuploader requests docopt 01:37:51 INFO - Cleaning up... 01:37:51 INFO - Return code: 0 01:37:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:51 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:51 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 01:37:51 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 01:37:51 INFO - Using env: {'DISPLAY': ':0', 01:37:51 INFO - 'HOME': '/home/cltbld', 01:37:51 INFO - 'LANG': 'en_US.UTF-8', 01:37:51 INFO - 'LANGUAGE': 'en_US:en', 01:37:51 INFO - 'LOGNAME': 'cltbld', 01:37:51 INFO - 'MAIL': '/var/mail/cltbld', 01:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:51 INFO - 'MOZ_NO_REMOTE': '1', 01:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:51 INFO - 'NO_EM_RESTART': '1', 01:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:51 INFO - 'PWD': '/builds/slave/test', 01:37:51 INFO - 'SHELL': '/bin/bash', 01:37:51 INFO - 'SHLVL': '1', 01:37:51 INFO - 'TERM': 'linux', 01:37:51 INFO - 'TMOUT': '86400', 01:37:51 INFO - 'USER': 'cltbld', 01:37:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:51 INFO - '_': '/tools/buildbot/bin/python'} 01:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:51 INFO - Running setup.py (path:/tmp/pip-LQspJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:51 INFO - Running setup.py (path:/tmp/pip-xfqwgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:51 INFO - Running setup.py (path:/tmp/pip-MKUyX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:52 INFO - Running setup.py (path:/tmp/pip-jOLUhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:52 INFO - Running setup.py (path:/tmp/pip-b29O_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:52 INFO - Running setup.py (path:/tmp/pip-6OQ3RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:52 INFO - Running setup.py (path:/tmp/pip-khVd89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:52 INFO - Running setup.py (path:/tmp/pip-ZJ9dU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:52 INFO - Running setup.py (path:/tmp/pip-rP1fkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:52 INFO - Running setup.py (path:/tmp/pip-vfhNjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:52 INFO - Running setup.py (path:/tmp/pip-jPPHuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:52 INFO - Running setup.py (path:/tmp/pip-B2MtRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:52 INFO - Running setup.py (path:/tmp/pip-pjyWbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:52 INFO - Running setup.py (path:/tmp/pip-vUpP_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:52 INFO - Running setup.py (path:/tmp/pip-xaAKrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:52 INFO - Running setup.py (path:/tmp/pip-RaGfHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:52 INFO - Running setup.py (path:/tmp/pip-90ELMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:37:53 INFO - Running setup.py install for manifestparser 01:37:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozcrash 01:37:53 INFO - Running setup.py install for mozdebug 01:37:53 INFO - Running setup.py install for mozdevice 01:37:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozfile 01:37:53 INFO - Running setup.py install for mozhttpd 01:37:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozinfo 01:37:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozInstall 01:37:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:37:53 INFO - Running setup.py install for mozleak 01:37:53 INFO - Running setup.py install for mozlog 01:37:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for moznetwork 01:37:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for mozprocess 01:37:54 INFO - Running setup.py install for mozprofile 01:37:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for mozrunner 01:37:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Running setup.py install for mozscreenshot 01:37:54 INFO - Running setup.py install for moztest 01:37:54 INFO - Running setup.py install for mozversion 01:37:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:37:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:37:54 INFO - Cleaning up... 01:37:54 INFO - Return code: 0 01:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:54 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:54 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 01:37:54 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 01:37:54 INFO - Using env: {'DISPLAY': ':0', 01:37:54 INFO - 'HOME': '/home/cltbld', 01:37:54 INFO - 'LANG': 'en_US.UTF-8', 01:37:54 INFO - 'LANGUAGE': 'en_US:en', 01:37:54 INFO - 'LOGNAME': 'cltbld', 01:37:54 INFO - 'MAIL': '/var/mail/cltbld', 01:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:54 INFO - 'MOZ_NO_REMOTE': '1', 01:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:54 INFO - 'NO_EM_RESTART': '1', 01:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:54 INFO - 'PWD': '/builds/slave/test', 01:37:54 INFO - 'SHELL': '/bin/bash', 01:37:54 INFO - 'SHLVL': '1', 01:37:54 INFO - 'TERM': 'linux', 01:37:54 INFO - 'TMOUT': '86400', 01:37:54 INFO - 'USER': 'cltbld', 01:37:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:54 INFO - '_': '/tools/buildbot/bin/python'} 01:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:55 INFO - Running setup.py (path:/tmp/pip-2fMubF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:55 INFO - Running setup.py (path:/tmp/pip-lySBw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:55 INFO - Running setup.py (path:/tmp/pip-4EdIKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:55 INFO - Running setup.py (path:/tmp/pip-9yOBrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:55 INFO - Running setup.py (path:/tmp/pip-6owqgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:55 INFO - Running setup.py (path:/tmp/pip-_wz5kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:55 INFO - Running setup.py (path:/tmp/pip-l_okeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:55 INFO - Running setup.py (path:/tmp/pip-Ll5qRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:55 INFO - Running setup.py (path:/tmp/pip-UtYSjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:55 INFO - Running setup.py (path:/tmp/pip-FKnQqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:55 INFO - Running setup.py (path:/tmp/pip-TCaFzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:55 INFO - Running setup.py (path:/tmp/pip-RMaZ2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:55 INFO - Running setup.py (path:/tmp/pip-a5JsDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:55 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)) 01:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:55 INFO - Running setup.py (path:/tmp/pip-bThqLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:56 INFO - Running setup.py (path:/tmp/pip-4Ip_Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:56 INFO - Running setup.py (path:/tmp/pip-X_ydsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:56 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)) 01:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:56 INFO - Running setup.py (path:/tmp/pip-hR6JQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:56 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)) 01:37:56 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)) 01:37:56 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)) 01:37:56 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)) 01:37:56 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)) 01:37:56 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)) 01:37:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:37:56 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 01:37:56 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 01:37:56 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 01:37:56 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 01:37:56 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 01:37:56 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 01:37:58 INFO - Downloading blessings-1.6.tar.gz 01:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:37:58 INFO - Installing collected packages: blessings 01:37:58 INFO - Running setup.py install for blessings 01:37:58 INFO - Successfully installed blessings 01:37:58 INFO - Cleaning up... 01:37:58 INFO - Return code: 0 01:37:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:58 INFO - Reading from file tmpfile_stdout 01:37:58 INFO - Current package versions: 01:37:58 INFO - argparse == 1.2.1 01:37:58 INFO - blessings == 1.6 01:37:58 INFO - blobuploader == 1.2.4 01:37:58 INFO - docopt == 0.6.1 01:37:58 INFO - functools32 == 3.2.3-2 01:37:58 INFO - jsonschema == 2.5.1 01:37:58 INFO - manifestparser == 1.1 01:37:58 INFO - mozInstall == 1.12 01:37:58 INFO - mozcrash == 0.17 01:37:58 INFO - mozdebug == 0.1 01:37:58 INFO - mozdevice == 0.48 01:37:58 INFO - mozfile == 1.2 01:37:58 INFO - mozhttpd == 0.7 01:37:58 INFO - mozinfo == 0.9 01:37:58 INFO - mozleak == 0.1 01:37:58 INFO - mozlog == 3.2 01:37:58 INFO - moznetwork == 0.27 01:37:58 INFO - mozprocess == 0.22 01:37:58 INFO - mozprofile == 0.28 01:37:58 INFO - mozrunner == 6.11 01:37:58 INFO - mozscreenshot == 0.1 01:37:58 INFO - mozsystemmonitor == 0.3 01:37:58 INFO - moztest == 0.7 01:37:58 INFO - mozversion == 1.4 01:37:58 INFO - psutil == 3.1.1 01:37:58 INFO - requests == 1.2.3 01:37:58 INFO - wsgiref == 0.1.2 01:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:58 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:58 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 01:37:58 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 01:37:58 INFO - Using env: {'DISPLAY': ':0', 01:37:58 INFO - 'HOME': '/home/cltbld', 01:37:58 INFO - 'LANG': 'en_US.UTF-8', 01:37:58 INFO - 'LANGUAGE': 'en_US:en', 01:37:58 INFO - 'LOGNAME': 'cltbld', 01:37:58 INFO - 'MAIL': '/var/mail/cltbld', 01:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:58 INFO - 'MOZ_NO_REMOTE': '1', 01:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:58 INFO - 'NO_EM_RESTART': '1', 01:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:58 INFO - 'PWD': '/builds/slave/test', 01:37:58 INFO - 'SHELL': '/bin/bash', 01:37:58 INFO - 'SHLVL': '1', 01:37:58 INFO - 'TERM': 'linux', 01:37:58 INFO - 'TMOUT': '86400', 01:37:58 INFO - 'USER': 'cltbld', 01:37:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:58 INFO - '_': '/tools/buildbot/bin/python'} 01:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 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)) 01:37:58 INFO - Cleaning up... 01:37:58 INFO - Return code: 0 01:37:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:58 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 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:58 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 01:37:58 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 01:37:58 INFO - Using env: {'DISPLAY': ':0', 01:37:58 INFO - 'HOME': '/home/cltbld', 01:37:58 INFO - 'LANG': 'en_US.UTF-8', 01:37:58 INFO - 'LANGUAGE': 'en_US:en', 01:37:58 INFO - 'LOGNAME': 'cltbld', 01:37:58 INFO - 'MAIL': '/var/mail/cltbld', 01:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:58 INFO - 'MOZ_NO_REMOTE': '1', 01:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:58 INFO - 'NO_EM_RESTART': '1', 01:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:58 INFO - 'PWD': '/builds/slave/test', 01:37:58 INFO - 'SHELL': '/bin/bash', 01:37:58 INFO - 'SHLVL': '1', 01:37:58 INFO - 'TERM': 'linux', 01:37:58 INFO - 'TMOUT': '86400', 01:37:58 INFO - 'USER': 'cltbld', 01:37:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:58 INFO - '_': '/tools/buildbot/bin/python'} 01:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:37:59 INFO - Cleaning up... 01:37:59 INFO - Return code: 0 01:37:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68409d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12af350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', '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 01:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:37:59 INFO - Using env: {'DISPLAY': ':0', 01:37:59 INFO - 'HOME': '/home/cltbld', 01:37:59 INFO - 'LANG': 'en_US.UTF-8', 01:37:59 INFO - 'LANGUAGE': 'en_US:en', 01:37:59 INFO - 'LOGNAME': 'cltbld', 01:37:59 INFO - 'MAIL': '/var/mail/cltbld', 01:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:59 INFO - 'MOZ_NO_REMOTE': '1', 01:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:37:59 INFO - 'NO_EM_RESTART': '1', 01:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:59 INFO - 'PWD': '/builds/slave/test', 01:37:59 INFO - 'SHELL': '/bin/bash', 01:37:59 INFO - 'SHLVL': '1', 01:37:59 INFO - 'TERM': 'linux', 01:37:59 INFO - 'TMOUT': '86400', 01:37:59 INFO - 'USER': 'cltbld', 01:37:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:59 INFO - '_': '/tools/buildbot/bin/python'} 01:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:59 INFO - Downloading/unpacking flake8 01:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:38:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:38:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:38:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:01 INFO - no previously-included directories found matching 'docs/_build' 01:38:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:38:01 INFO - Running setup.py install for pep8 01:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:02 INFO - no previously-included directories found matching 'docs/_build' 01:38:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:38:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:38:02 INFO - Cleaning up... 01:38:02 INFO - Return code: 0 01:38:02 INFO - Running post-action listener: _resource_record_post_action 01:38:02 INFO - Running post-action listener: _start_resource_monitoring 01:38:02 INFO - Starting resource monitoring. 01:38:02 INFO - ##### 01:38:02 INFO - ##### Finished create-virtualenv step (success) 01:38:02 INFO - ##### 01:38:02 INFO - ##### 01:38:02 INFO - ##### Running install step. 01:38:02 INFO - ##### 01:38:02 INFO - Running pre-action listener: _resource_record_pre_action 01:38:02 INFO - Running main action method: install 01:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:02 INFO - Reading from file tmpfile_stdout 01:38:02 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:02 INFO - Reading from file tmpfile_stdout 01:38:02 INFO - Output received: 01:38:02 INFO - Usage: mozinstall [options] installer 01:38:02 INFO - Options: 01:38:02 INFO - -h, --help show this help message and exit 01:38:02 INFO - -d DEST, --destination=DEST 01:38:02 INFO - Directory to install application into. [default: 01:38:02 INFO - "/builds/slave/test"] 01:38:02 INFO - --app=APP Application being installed. [default: firefox] 01:38:02 INFO - mkdir: /builds/slave/test/build/application 01:38:02 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'] 01:38:02 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 01:38:18 INFO - Reading from file tmpfile_stdout 01:38:18 INFO - Output received: 01:38:18 INFO - /builds/slave/test/build/application/firefox/firefox 01:38:18 INFO - Running post-action listener: _resource_record_post_action 01:38:18 INFO - ##### 01:38:18 INFO - ##### Finished install step (success) 01:38:18 INFO - ##### 01:38:18 INFO - ##### 01:38:18 INFO - ##### Running run-tests step. 01:38:18 INFO - ##### 01:38:18 INFO - Running pre-action listener: _resource_record_pre_action 01:38:18 INFO - Running main action method: run_tests 01:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:18 INFO - Python 2.7.3 01:38:18 INFO - Return code: 0 01:38:18 INFO - grabbing minidump binary from tooltool 01:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:18 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 0x133e1c0>, '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 0x133f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:18 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 01:38:18 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 01:38:18 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 01:38:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:18 INFO - Return code: 0 01:38:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:38:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:38:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:38:19 INFO - Return code: 0 01:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 01:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 01:38:19 INFO - Using env: {'DISPLAY': ':0', 01:38:19 INFO - 'HOME': '/home/cltbld', 01:38:19 INFO - 'LANG': 'en_US.UTF-8', 01:38:19 INFO - 'LANGUAGE': 'en_US:en', 01:38:19 INFO - 'LOGNAME': 'cltbld', 01:38:19 INFO - 'MAIL': '/var/mail/cltbld', 01:38:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:19 INFO - 'MOZ_NO_REMOTE': '1', 01:38:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:38:19 INFO - 'NO_EM_RESTART': '1', 01:38:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:19 INFO - 'PWD': '/builds/slave/test', 01:38:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:19 INFO - 'SHELL': '/bin/bash', 01:38:19 INFO - 'SHLVL': '1', 01:38:19 INFO - 'TERM': 'linux', 01:38:19 INFO - 'TMOUT': '86400', 01:38:19 INFO - 'USER': 'cltbld', 01:38:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514', 01:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:19 INFO - '_': '/tools/buildbot/bin/python'} 01:38:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 01:38:19 INFO - mozversion application_buildid: 20160615235725 01:38:19 INFO - mozversion application_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 01:38:19 INFO - mozversion application_display_name: Nightly 01:38:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:19 INFO - mozversion application_name: Firefox 01:38:19 INFO - mozversion application_remotingname: firefox 01:38:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:38:19 INFO - mozversion application_vendor: Mozilla 01:38:19 INFO - mozversion application_version: 50.0a1 01:38:19 INFO - mozversion platform_buildid: 20160615235725 01:38:19 INFO - mozversion platform_changeset: c914e1312fd6cede0da6dcaa1c605eaf07849138 01:38:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:38:19 INFO - mozversion platform_version: 50.0a1 01:38:19 INFO - using testdate: 1466066299 01:38:19 INFO - actual date: 1466066299 01:38:19 INFO - starting webserver on 'localhost:44698' 01:38:19 INFO - SUITE-START | Running 2 tests 01:38:19 INFO - TEST-START | dromaeo_css 01:38:19 INFO - operating with platform_type : linux_ 01:38:19 INFO - Initialising browser for dromaeo_css test... 01:38:19 INFO - TEST-INFO | started process 27778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ22BrL/profile http://localhost:44698/getInfo.html) 01:38:24 INFO - PROCESS | 27778 | __metrics Screen width/height:1600/1200 01:38:24 INFO - PROCESS | 27778 | colorDepth:24 01:38:24 INFO - PROCESS | 27778 | Browser inner width/height: 1024/697 01:38:24 INFO - PROCESS | 27778 | __metrics 01:38:25 INFO - PROCESS | 27778 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:38:25 INFO - PROCESS | 27778 | console.error: PushService: 01:38:25 INFO - PROCESS | 27778 | stateChangeProcessEnqueue: Error transitioning state 01:38:25 INFO - PROCESS | 27778 | UnknownError 01:38:26 INFO - TEST-INFO | 27778: exit 0 01:38:26 INFO - Browser initialized. 01:38:26 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:26 INFO - TEST-INFO | started process 27861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ22BrL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:38 INFO - PROCESS | 27861 | RSS: Main: 175960064 01:38:38 INFO - PROCESS | 27861 | 01:39:29 INFO - PROCESS | 27861 | 1466066369371 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] 01:41:42 INFO - PROCESS | 27861 | Cycle 1(1): loaded http://localhost:44698/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44698/tests/dromaeo/cssquery-ext.html) 01:41:43 INFO - PROCESS | 27861 | RSS: Main: 290168832 01:41:43 INFO - PROCESS | 27861 | 01:44:46 INFO - PROCESS | 27861 | Cycle 1(1): loaded http://localhost:44698/tests/dromaeo/cssquery-ext.html (next: http://localhost:44698/tests/dromaeo/cssquery-jquery.html) 01:44:46 INFO - PROCESS | 27861 | RSS: Main: 258822144 01:44:46 INFO - PROCESS | 27861 | 01:47:49 INFO - PROCESS | 27861 | Cycle 1(1): loaded http://localhost:44698/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44698/tests/dromaeo/cssquery-mootools.html) 01:47:49 INFO - PROCESS | 27861 | RSS: Main: 258846720 01:47:49 INFO - PROCESS | 27861 | 01:50:51 INFO - PROCESS | 27861 | Cycle 1(1): loaded http://localhost:44698/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44698/tests/dromaeo/cssquery-prototype.html) 01:50:52 INFO - PROCESS | 27861 | RSS: Main: 255250432 01:50:52 INFO - PROCESS | 27861 | 01:53:55 INFO - PROCESS | 27861 | Cycle 1(1): loaded http://localhost:44698/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44698/tests/dromaeo/cssquery-yui.html) 01:53:56 INFO - PROCESS | 27861 | RSS: Main: 236847104 01:53:56 INFO - PROCESS | 27861 | 01:56:58 INFO - PROCESS | 27861 | Cycle 1(1): loaded http://localhost:44698/tests/dromaeo/cssquery-yui.html (next: http://localhost:44698/tests/dromaeo/cssquery-dojo.html) 01:56:59 INFO - PROCESS | 27861 | RSS: Main: 266551296 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | __start_tp_report 01:56:59 INFO - PROCESS | 27861 | _x_x_mozilla_page_load 01:56:59 INFO - PROCESS | 27861 | _x_x_mozilla_page_load_details 01:56:59 INFO - PROCESS | 27861 | |i|pagename|runs| 01:56:59 INFO - PROCESS | 27861 | |0;dojo.html;2606.0487921908502;2627.68467783866;2649.0728245114205;2661.334666333417;2668.1862032080207;4610.861674149781;4682.157211701892;4685;4749.073930583538;4792.305115758213;4727.432708075027;4739.14695354836;4849.248366503198;4858.46556878743;4866;4346.391505189268;4352.586504282104;4410.051838854645;4470;4569.634429245652;4467.30756732707;4518.164139634162;4535.841245556406;4547.272436410175;4569.1547063793305;4272.914541709149;4308.009157893702;4309.2458819706735;4317.11499142675;4430.357598148251;4327.2643650579475;4337.219300525904;4344.087741574273;4355.5644435556505;4399.406080179167;4383.123375324948;4390.692651514395;4397.318415645548;4397.626201772853;4434.157510073108;4556.977215113903;4695.413073365829;4761.095391875567;4782.713037217778;4824.541668541483;5126.92309615356;5186.273921650972;5192.247124167013;5194.480551944813;5198.376194856603;5185.662931909414;5187.948120518822;5219.817306394296;5224.817131400421;5228.451012643655;4645.883852903637;4734.242521196592;4761.571458568746;4769.070031343855;4872.780724867425;5201.609879259071;5272.2882410874045;5302.893942121136;5321.627486076015;5322.92015619766;5027.622928280321;5040.899182016339;5045.268436076748;5096.9490305097215;5107.182850743863;5019.0965626187635;5030.471800460972;5072.239164125337;5083;5115.335006449138;5038.546530812245;5073.492650734897;5077.416097148875;5088.313077734532;5125.589952803767;4923.433805112386;5070.264811602297;5076.974615126975;5082.695038297714;5090.185570308733;4270.48754149504;4304.80628371724;4372.322290045048;4380.430544029319;4430.401895744098;3822.2928758179823;3822.961770382316;3830.4254361845387;3872.361060425055;3873.4189871518934;4422.867313980586;4425.668074894332;4426.0483995940385;4464.308032255006;4473.172463094338;4957.90084198314;5009.073321435546;5011.398632164163;5020.648554601216;5133.409657889316;4337.457817772778;4353.586409291175;4354.695171337976;4362.345648152803;4415.668824838086;4580.679352445297;4592.334111553806;4593.425821772278;4597.218472859622;4635.281531362644;4716.080364328923;4767.976160119178;4791.47293797682;4798.1123492154065;4799.640026998059;5126.7180305083575;5167.354080739908;5173.611979101507;5174.120399532164;5190.714510701797;4803.03939212152;4836.540528649773;4849.709017458964;4851.56335929768;4883.560479556857;4813.374261346003;4984.077945580079;5005.199168133081;5045.949540504548;5141.254518094781;5123.231515272739;5130.153524668388;5135.87160320995;5141.532064608934;5148.176291793295;5005.599552035901;5006.924896126488;5008.298838162587;5012.122878496176;5043.470435604356;4864.075825593126;4942.629302802232;4979.975100124476;4999.47505511916;5027.446980832178;4905.141600219876;4958.801647934187;4990.076835785391;4994.900101998012;4995.100881841304;4867.026594681149;5018.347614810197;5026.447090819934;5030.798768049237;5055.317532133115;4835.105505481497;4839.95160048395;4851.151048566416;4873.561379475864;4878.926816097833 01:56:59 INFO - PROCESS | 27861 | |1;ext.html;534.5007011046672;588.2558563417276;591.0926727473329;594.5629961977943;608.3490664988461;26287.211383658472;26859.865700671493;39665.40501892474;39689.20621587567;40854;37521.249575008485;42524.36213456801;42555.14889702204;42588.14823703524;42629.57370426295;7828.334591559725;7867.7246296379635;7921.405894557903;7922.683092676286;7975.561344126071;7599.354054905312;10017.549210285519;10247.795044099114;10248.74378140545;10607.257491975564;10073.345232559861;10161.339512931672;10161.593536258577;10164.237682173829;10168.59325626974;10178.287519873611;10219.437930913797;10257.384556926609;10258.794824103476;10270.89729102707;10052.195824334109;10158.187345012382;10158.542865571068;10162.18702503798;10164.339317944385;38876.222475550334;39084;39107.41338879919;39136.80431597852;39210.607893920984;3111.222194451387;3144.166795799115;3250.398676244902;3539.309834582232;3715.6623615498397;29216.561751573532;29865.70134298651;30738.38523229523;31213.37573248545;31221;3582.265635544707;3595.8381872815785;3597.1546686528905;3643.7995910224927;3702.666759991587;219565;220589;220972;221108;221578;52276.21585676218;52841.73579132157;52964;52969.735151324;53001.2049819253;56794.43205567974;56800.715996419756;56847.43152568422;56872.715636421555;56995.15024248771;13289.800652990212;13769.793453098211;13772.724545509034;13778.448862045607;13784.655383615489;9645.08371704687;10011.149052330487;10156.4921753912;10190.745231369276;10214.336068155546;16551.25519351632;16645.33418663264;16699.582510437336;16724.080175590218;16736;5818.156367326714;5913.556483263773;5928.4960778334325;6053.697315134225;6053.7578496860515;821.3839620284787;856.3235044314921;930.1628534319167;969.4231932000589;1033.813913495563;27342.863285683445;27582.44835103287;27600.723992759817;27610;28012;967.7967626798311;979.4368238262884;1024.8513965474965;1036.76154484469;1046.2362475392854;14325;14818.851811481747;14902.403903843942;15091.773623395438;15205.847941520664;366420;369922;369926;369950;370333;46497.76751116223;47501.76249118801;47560.5243947563;47560.7621961888;47844.28233576499;1096.950637221327;1128.08061429936;1190.7618476304601;1192.65413030222;1209.3348658237935;27375.315617109733;28498.715012849607;28568.57147142836;28918.855405722836;29304.26739331534;41154;41521;41664.3750343739;41698.374524382765;41721;295632;297768;298363;299001;299223;30877.228069298446;31949.36101278008;36094.278114438086;37079.814600926824;37113.62886371102;40673.59326406698;41061.48323684333;41326.586734132274;41834.372484412146;42356.57643423526;34906.825465872505;35387.646123538434;35418.64581354154;36003.27993440169;36110.819445902605;35078.824605876805;35118.12204694903;35185.296294074484;35481.29037419289;35760.28479430449;34908.82545587256;34994.125146871535;35184.64815351814;35357.46963795597;35693.64306357007;31249.531257031616;31996.6800332003;32139.196520087185;32166.356672865943;32369.838150809097;24651.876740616182;24846.25461236166;24886.626700599143;25291.620625690997;25311.114111006027 01:56:59 INFO - PROCESS | 27861 | |2;jquery.html;372.5975945978343;374.9418840079788;377.6186052087391;388.94165875118745;391.5770967355257;16038.83961160388;16221.18894055297;17211.22549485273;17238.74141887871;18077.548061298476;11067.667969960894;15647.921760391182;16595.751063734053;16617.750733739005;17414.129293535338;3524.365614189445;4574.771261436923;4776.211925032366;4779.617630589544;4780.426348838144;3676.4301533262387;5225;5567.137093750455;5578.135389014709;5654.9717251413895;5185.611079169059;5640.153976903456;5642.7178641067985;5645.350784659776;5646.2942132233475;3482.3035392921265;5431.158170483562;5486.890262194774;5518.448155184489;5532.612717109804;5096.51583099605;5412.729363531807;5422.484863937959;5493.121100623921;5504.80733174337;12279.263244205376;12697.238165710087;12734.745305093846;16188.35246590135;20121.597568048557;1951.2780271299569;1988.7514060742408;2043.5402034542258;2180.095260466904;2429.817763667732;8915.420497667696;9020.8646870297;9323.766905827408;9368.484733339663;11326.546938122548;1698.1678977301158;1730.1522254095528;1732.5322163015915;1768.4341010876524;1788.6601545706274;63487;64763.99670518904;65859.67070164667;65960.34039659638;67203;9631.136276180625;9800.55897484615;9865.112139907444;9937.900620993698;10533;13571.52499662507;13601;13604.93197534006;13667.316634168252;13674.93162534181;6544.934550654432;6754.797356079325;6780.93219067803;6815.386615204557;6869.828254293682;6275.497960163176;6314.242290925118;6344.936550634435;6365.649889256136;6382.712777925005;4267.103908179255;4279.079997800488;4285.37862010013;4320.243957307459;4371.75955322454;1580.2809721576884;1670.741035139531;1780.9554761130817;1791.6954117800005;1864.0334447158107;803.1446509467398;837.7905523619095;876.268315956171;938.9530673299222;943.3585162089845;15434.536963891102;15751.13368764706;15971;16403.67192656164;16407.671846563;835.511225932824;836.9748907532784;856.4561503445357;866.8093019535692;889.6174644902625;8377.6230069647;8686.826263474695;9129.45223286605;9168.312376571785;9256.537173141316;360301;365402;383825;385895;387273;71665;72501;73933.26066739371;73987;76813.6159319211;842.1872892658614;860.4966094834592;862.2670729879677;868.2186032570611;870.9520976346362;14691.884326969008;14882.255887205813;14984;15158.690677544435;15342.76985845191;35732.82133589315;36213.45679814752;36508;36796;38578.6142138575;47291.52708472871;48747.268790968876;48927.26609100795;49143.262851057974;49151.50848491612;7437.256274372519;7642.465027448247;7645.885311720217;7696.384289256734;7829.7259595913865;6698.894682377353;8589.742307730778;11123.72190695239;11416;11496;9892.258080644124;10047.849282260626;10059.144972677404;10244.436555989492;10262.384256944608;9965.651202208179;9992.10071093605;10022.3485473444;10063.849042264519;10086.848697269694;10001.34991225568;10089.949550252202;10290.948545257226;10303.278770485995;10312.123469505175;10964.780704385708;11111.277766945122;11186.496607652512;11386.373749443861;11487.253328533952;9883.159931405911;10166.8474972874;10882.45587720595;11091;11244.10047196206 01:56:59 INFO - PROCESS | 27861 | |3;mootools.html;1211.660734994202;1361.8025386318984;1399.8600139986;1451.194587004213;1630.2745278351138;7029.89455158173;7349.889751653723;7369.852602947938;7540;7555.924440755591;7418.480706350544;7556.168821429638;7564.62176891156;7571.6214189290595;7584.203658615848;2162.0703097667997;2186.431527802775;2187.3000639795273;2188.0919418441326;2189.35414052854;2181.7600063993027;2205.2502149269244;2213.070510385634;2225.4658881868318;2226.5101677630896;2164.83763717721;2166.144372972675;2193.0898677049004;2195.2316689158824;2198.692183094368;2085;2119.6078725435846;2119.7774233705395;2121.8302535797175;2123.4797474618663;2083.406229224679;2114.534802343482;2133.136079887648;2140.336495686342;2146.61360955028;7312.890306645405;7500.774976750707;7556.735514256975;7566.394688424913;7582.582957937311;4440.800163992628;4543.204939135671;4550.13547425988;4553;4555.339475775994;2699.7030326664053;2832.3202431416516;2859.628248327725;2864.398476319975;2866.7133286671374;926.0785518409226;934.4159900062461;937.8124375125002;941.9387739796891;953.918916892065;9863.704088877344;9907.058829411195;9981.351212171257;9982.151517120981;10001;3749.1189570450924;3842.8078596070086;3931.7837518936735;3951.4665520154986;3969.384745364473;7844.058712954482;7922.564258965812;7947.324477419368;7961.522308661499;7968.7609371718945;4384.386185933972;4390.736555806662;4400.361947517592;4401.163778882003;4404.911901761947;3653;4013.7190396671954;4025.0943537703783;4085.8978525536504;4106.281400754856;3264.4450443424676;3298.191942973987;3388.0852169913987;3398.864045438155;3399.9150021249666;1005.8491226316111;1030.7886883188928;1032.7573020340214;1041.3855825063097;1047.4553232319151;720.6180724216174;799.5043073294595;805.9717909873126;818.0878320672407;822.7531740477953;4643.442786865598;4702.576768090888;4741.83403580873;4885.853424397203;4899.412070551485;408.28957613752453;408.8793805827288;414.0621492319898;421.1303657946331;426.9231538323132;3239.6922292382187;3254.5769050023346;3378.138574663445;3390.71178949792;3506.859725610998;8920.776980575538;8936.50849203287;8943.776405589782;9002.279817614575;9011.459312441275;8992.55037248148;9050.049744776836;9074.637014519345;9077.863832042525;9103.772405689911;6757.898631520531;6990.161180658353;7016.649167541705;7026.367626913602;7171.7489887852635;4906.386701662293;4966.826161084345;5052.267421223975;5055.848324550269;5115.514026167508;8196.098429172667;8453.830923381622;8709;8709;8750.912490875264;8605.268552173135;8783.560821958748;8804.427712198687;8829.205371516595;8915.777105572413;5900.64596124234;6440.355964403522;6647.169103862017;6770.5599136056;6803;7357.153927298429;7402.703891844266;7430.517016393917;7437.219091995263;7440.776776696708;6336.778212762531;6615.536912416277;6668.366505182;6713.362230588086;6768.323167683192;6173.135760993554;6605.141331626858;6631.966840165961;6657.600543967377;6673.099131617364;5925.762969481172;6064.151018857452;6103.389661033861;6111.541634377529;6112.205413296243;3788.791616461121;3926.587708290588;3976.3439032559304;4009.3985902114914;4062.6749860010536;4147.983743982743;4179.895502612459;4241.681873859535;4305.547917468621;4380.0582874682095 01:56:59 INFO - PROCESS | 27861 | |4;prototype.html;296.6855133558428;301.83700801567153;302.0997427665557;307.6631088957592;308.6111499510616;4850.9029819403595;4852.927206091911;4863.781129849156;4878.877518388225;4882.926756098661;4824.118593748441;4831.227003679403;4852;4860.586850117736;4889.24216746404;3629.6914762245174;3713.535808023997;3737.3085979093817;3819.484369610109;3857.498525191721;3803.7147213958924;3813.675837553811;3824;3832.2527107213964;3840.347140986039;3645;3786.2995345861104;3787.9810600946957;3790.2040571479884;3799.620037996206;3732.216234590739;3786.2238241160494;3797.620237976208;3798.4112462568346;3810.5617853946874;3373.6795004474534;3394.6435624259343;3396.6603339666085;3398.4052790761516;3399.55805745254;4719.952800471986;4723.976380118112;4734.088535550612;4747.572718455321;4763.857084287477;4207.158568286355;4340.674449416275;4342.370356298351;4361.6074553290355;4374.868753937387;5044.672096313728;5059.342285502861;5065.670731402447;5072.503611434636;5079.619028572872;3660.7803531788177;3680.589214064792;3693.0582701411236;3694.039549717066;3708.8516459341595;5197.428282888879;5274.894502109936;5296.841094767202;5315.362156541201;5315.840524784263;3747.437884317374;3775.981120094437;3790.1851102013197;3792.981035094862;3803;3838.2323535292494;3851.5378154621626;3864.9227015460096;3867.690584753213;3881.8835434936996;4328.761918094535;4334.609885110355;4361.454818147731;4379.4525684289465;4394.604485596312;4898.9712160446;5067.822626208139;5086.745662716849;5104.617153713486;5110.8756073663735;1288.4910460368103;1321.1808678619318;1323.7551053055215;1325.0923117664238;1328.2561765411401;861.814709837388;863.2662237098542;911.5168960450972;936.2089034765612;942.1520631431766;4504.572065653823;4506.324051392317;4507.211238033331;4512.887177820581;4547.590247023433;5182.870428239325;5185.585153187736;5186.273921650972;5226;5240.790368385298;4323.589259020388;4474.127545128668;4479.641628669699;4494.011317510142;4580.450345958507;2827.3638431353193;2842.9431411371656;2849.8147620404607;2851.918099787167;2860.3707184419395;4965.318727886973;4991.825286115041;5000;5010.198368261061;5010.298558201855;5060.569851562658;5379.28346185174;5383.650062745909;5458.153986132156;5462.9726851365485;4934.506549345108;4934.9753251233515;4954.711774938614;4973.8010479581135;4981.003799240167;5247.868803279948;5290.206469029523;5307.363116426053;5329.227262047059;5333.146696528692;4870.245112007645;5122.923156152735;5162.045021671003;5162.174052151638;5207.895842083213;4893.437254715754;4944.381952255968;4946.505349465025;4950.653454258311;4965.577925876341;3768.9811550942068;3780.905477363088;3794.1083845296885;3797.3544497436055;3799.544054713452;5165.992631436834;5234.685918844882;5254.238135470412;5258.263843062051;5340.839774806762;5030.4718004608985;5068.442471328225;5079.415867175175;5097.7706003229205;5102;5113.463086375877;5118.334616499831;5121.0795951518185;5129.897402052013;5138.871528211825;4805.471398146131;4889.63327750413;5012.448630650699;5030.220315851049;5055.241713742968;5042.647014709082;5173.499685091281;5175.585953123817;5176.870578235575;5178.818741344186;5047;5098.1842905135;5119.334486516878;5128.923066154085;5132.8460146195675 01:56:59 INFO - PROCESS | 27861 | |5;yui.html;606.5935822998591;608.0484042473529;622.1259130921055;623.691272819954;656.5207398599019;13028.739425211503;13052.216866987976;13428.462861485528;13449.865501344984;13640.113392629484;12878.484860605588;12933.224006559612;12995.740085198291;13048.151870128435;13068.73862522749;626.7618305044077;738.2322384719912;761.5012167030604;768.4966347042696;787.2953706432739;799.2526987266895;802.0295442514564;802.0856223904754;802.1016461563057;802.1256830055239;833.7623777223492;833.9583020848934;834.870595057767;834.9791255218607;835.1606635331483;649.3182158733312;798.4690181029638;823.1151512124491;825.9958700206461;828.3828547731918;607.0439058482907;608.4615115622662;610.6854969690613;611.0864257934417;611.2420598457925;13062.934685326607;13091.47634094635;13101.08292419531;13106.60680179596;13115.934420327838;12648.747025059447;13020.348982550835;13026.153300035467;13063.34683265833;13470.057096003284;11564.653060408116;11633.883661163449;11647.534098636044;11770.882291177064;11984.161108722394;4158.147579746144;4186.0581369192;4217.894552636178;4252.936205956913;4283.100548884738;58811;59443.40556594465;60008.399916000715;60940.08589871156;61329;10277.7430564235;10339.793204135874;10349.223808214414;10520.421376824348;10529.526171322308;18499.630007399777;18555;18563.628727425377;18582.44252672422;18611.441656750318;6565.080888675589;6635.767748128792;6830.316968303229;6925;7141.571505709674;3764.284785890672;3768.8304026318883;3785.602511736228;3834.654881060718;3938.6849052075763;2673.5454972654697;2766.073365422606;2769.9723002770115;2771.0993926973815;2772.348498102944;416.63336264088014;497.7312251384212;519.7011718262014;519.9714015729171;544.0913674164156;527.7123967437756;533.4230618879604;552.2985808023788;556.8552176434156;567.8410045187354;7391.2978267064545;7567.735129270449;7595.468317217852;8006.719764808204;8066.274035336848;581.7236812514022;596.8895754285471;599.6851652882272;614.8862460444832;615.722924683894;3623.3115708015393;3706.3328600852105;3765.642263984917;3778.7165962552917;3785.905352366158;99700;100053.49973250087;100191.49904250578;102018;102712;86760;90432;90636.5468172655;90852.54573727089;91053.54473227591;59333;61425.69287153625;78607;80642;81171.18828811754;8324.417290789586;8405.915940840758;8475.74572762818;8588.742337729878;8676.436031657922;35704.464433033005;41486.79256603698;42225.94435139146;42238.155236895705;42839.3574096395;38670.2265954685;52903;54845.177322341;54937.1759423617;56170;11541.480633371351;11553.480093395985;11674;11904.226225295328;12211.938940305241;12708.682282943;12756.74486510246;12894.806577901527;13214.603561893158;13345.266010369134;11848.170628055954;12096.455659495168;12342.938285308515;12748.362581871055;13093.083484156017;11840.822387664364;12071.215371000857;12409.503619855104;12530.498780048696;13107.606771796862;12302.692432688897;12419.068569857116;12560.12079154487;13008.804867927178;13023.479060837839;9940.353876997971;9978.800423991624;10125.594976201164;10244.59021639156;10618.575256989634;9886.30795844284;10651.89348106509;10690;10762.569497220024;10762.748714257981 01:56:59 INFO - PROCESS | 27861 | __end_tp_report 01:56:59 INFO - PROCESS | 27861 | __start_cc_report 01:56:59 INFO - PROCESS | 27861 | _x_x_mozilla_cycle_collect,1085 01:56:59 INFO - PROCESS | 27861 | __end_cc_report 01:56:59 INFO - PROCESS | 27861 | __startTimestamp1466067419222__endTimestamp 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | ------- Summary: start ------- 01:56:59 INFO - PROCESS | 27861 | Number of tests: 6 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | [#0] dojo.html Cycles:165 Average:4725.91 Median:4849.71 stddev:498.26 (10.3%) stddev-sans-first:471.22 01:56:59 INFO - PROCESS | 27861 | Values: 2606.0 2627.7 2649.1 2661.3 2668.2 4610.9 4682.2 4685.0 4749.1 4792.3 4727.4 4739.1 4849.2 4858.5 4866.0 4346.4 4352.6 4410.1 4470.0 4569.6 4467.3 4518.2 4535.8 4547.3 4569.2 4272.9 4308.0 4309.2 4317.1 4430.4 4327.3 4337.2 4344.1 4355.6 4399.4 4383.1 4390.7 4397.3 4397.6 4434.2 4557.0 4695.4 4761.1 4782.7 4824.5 5126.9 5186.3 5192.2 5194.5 5198.4 5185.7 5187.9 5219.8 5224.8 5228.5 4645.9 4734.2 4761.6 4769.1 4872.8 5201.6 5272.3 5302.9 5321.6 5322.9 5027.6 5040.9 5045.3 5096.9 5107.2 5019.1 5030.5 5072.2 5083.0 5115.3 5038.5 5073.5 5077.4 5088.3 5125.6 4923.4 5070.3 5077.0 5082.7 5090.2 4270.5 4304.8 4372.3 4380.4 4430.4 3822.3 3823.0 3830.4 3872.4 3873.4 4422.9 4425.7 4426.0 4464.3 4473.2 4957.9 5009.1 5011.4 5020.6 5133.4 4337.5 4353.6 4354.7 4362.3 4415.7 4580.7 4592.3 4593.4 4597.2 4635.3 4716.1 4768.0 4791.5 4798.1 4799.6 5126.7 5167.4 5173.6 5174.1 5190.7 4803.0 4836.5 4849.7 4851.6 4883.6 4813.4 4984.1 5005.2 5045.9 5141.3 5123.2 5130.2 5135.9 5141.5 5148.2 5005.6 5006.9 5008.3 5012.1 5043.5 4864.1 4942.6 4980.0 4999.5 5027.4 4905.1 4958.8 4990.1 4994.9 4995.1 4867.0 5018.3 5026.4 5030.8 5055.3 4835.1 4840.0 4851.2 4873.6 4878.9 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | [#1] ext.html Cycles:180 Average:45773.17 Median:34951.48 stddev:79305.42 (226.9%) stddev-sans-first:79455.15 01:56:59 INFO - PROCESS | 27861 | Values: 534.5 588.3 591.1 594.6 608.3 26287.2 26859.9 39665.4 39689.2 40854.0 37521.2 42524.4 42555.1 42588.1 42629.6 7828.3 7867.7 7921.4 7922.7 7975.6 7599.4 10017.5 10247.8 10248.7 10607.3 10073.3 10161.3 10161.6 10164.2 10168.6 10178.3 10219.4 10257.4 10258.8 10270.9 10052.2 10158.2 10158.5 10162.2 10164.3 38876.2 39084.0 39107.4 39136.8 39210.6 3111.2 3144.2 3250.4 3539.3 3715.7 29216.6 29865.7 30738.4 31213.4 31221.0 3582.3 3595.8 3597.2 3643.8 3702.7 219565.0 220589.0 220972.0 221108.0 221578.0 52276.2 52841.7 52964.0 52969.7 53001.2 56794.4 56800.7 56847.4 56872.7 56995.2 13289.8 13769.8 13772.7 13778.4 13784.7 9645.1 10011.1 10156.5 10190.7 10214.3 16551.3 16645.3 16699.6 16724.1 16736.0 5818.2 5913.6 5928.5 6053.7 6053.8 821.4 856.3 930.2 969.4 1033.8 27342.9 27582.4 27600.7 27610.0 28012.0 967.8 979.4 1024.9 1036.8 1046.2 14325.0 14818.9 14902.4 15091.8 15205.8 366420.0 369922.0 369926.0 369950.0 370333.0 46497.8 47501.8 47560.5 47560.8 47844.3 1097.0 1128.1 1190.8 1192.7 1209.3 27375.3 28498.7 28568.6 28918.9 29304.3 41154.0 41521.0 41664.4 41698.4 41721.0 295632.0 297768.0 298363.0 299001.0 299223.0 30877.2 31949.4 36094.3 37079.8 37113.6 40673.6 41061.5 41326.6 41834.4 42356.6 34906.8 35387.6 35418.6 36003.3 36110.8 35078.8 35118.1 35185.3 35481.3 35760.3 34908.8 34994.1 35184.6 35357.5 35693.6 31249.5 31996.7 32139.2 32166.4 32369.8 24651.9 24846.3 24886.6 25291.6 25311.1 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | [#2] jquery.html Cycles:180 Average:23413.11 Median:4282.23 stddev:62150.79 (1451.4%) stddev-sans-first:62301.06 01:56:59 INFO - PROCESS | 27861 | Values: 372.6 374.9 377.6 388.9 391.6 16038.8 16221.2 17211.2 17238.7 18077.5 11067.7 15647.9 16595.8 16617.8 17414.1 3524.4 4574.8 4776.2 4779.6 4780.4 3676.4 5225.0 5567.1 5578.1 5655.0 5185.6 5640.2 5642.7 5645.4 5646.3 3482.3 5431.2 5486.9 5518.4 5532.6 5096.5 5412.7 5422.5 5493.1 5504.8 12279.3 12697.2 12734.7 16188.4 20121.6 1951.3 1988.8 2043.5 2180.1 2429.8 8915.4 9020.9 9323.8 9368.5 11326.5 1698.2 1730.2 1732.5 1768.4 1788.7 63487.0 64764.0 65859.7 65960.3 67203.0 9631.1 9800.6 9865.1 9937.9 10533.0 13571.5 13601.0 13604.9 13667.3 13674.9 6544.9 6754.8 6780.9 6815.4 6869.8 6275.5 6314.2 6344.9 6365.6 6382.7 4267.1 4279.1 4285.4 4320.2 4371.8 1580.3 1670.7 1781.0 1791.7 1864.0 803.1 837.8 876.3 939.0 943.4 15434.5 15751.1 15971.0 16403.7 16407.7 835.5 837.0 856.5 866.8 889.6 8377.6 8686.8 9129.5 9168.3 9256.5 360301.0 365402.0 383825.0 385895.0 387273.0 71665.0 72501.0 73933.3 73987.0 76813.6 842.2 860.5 862.3 868.2 871.0 14691.9 14882.3 14984.0 15158.7 15342.8 35732.8 36213.5 36508.0 36796.0 38578.6 47291.5 48747.3 48927.3 49143.3 49151.5 7437.3 7642.5 7645.9 7696.4 7829.7 6698.9 8589.7 11123.7 11416.0 11496.0 9892.3 10047.8 10059.1 10244.4 10262.4 9965.7 9992.1 10022.3 10063.8 10086.8 10001.3 10089.9 10290.9 10303.3 10312.1 10964.8 11111.3 11186.5 11386.4 11487.3 9883.2 10166.8 10882.5 11091.0 11244.1 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | [#3] mootools.html Cycles:180 Average:4875.95 Median:4902.90 stddev:2733.69 (55.8%) stddev-sans-first:2727.49 01:56:59 INFO - PROCESS | 27861 | Values: 1211.7 1361.8 1399.9 1451.2 1630.3 7029.9 7349.9 7369.9 7540.0 7555.9 7418.5 7556.2 7564.6 7571.6 7584.2 2162.1 2186.4 2187.3 2188.1 2189.4 2181.8 2205.3 2213.1 2225.5 2226.5 2164.8 2166.1 2193.1 2195.2 2198.7 2085.0 2119.6 2119.8 2121.8 2123.5 2083.4 2114.5 2133.1 2140.3 2146.6 7312.9 7500.8 7556.7 7566.4 7582.6 4440.8 4543.2 4550.1 4553.0 4555.3 2699.7 2832.3 2859.6 2864.4 2866.7 926.1 934.4 937.8 941.9 953.9 9863.7 9907.1 9981.4 9982.2 10001.0 3749.1 3842.8 3931.8 3951.5 3969.4 7844.1 7922.6 7947.3 7961.5 7968.8 4384.4 4390.7 4400.4 4401.2 4404.9 3653.0 4013.7 4025.1 4085.9 4106.3 3264.4 3298.2 3388.1 3398.9 3399.9 1005.8 1030.8 1032.8 1041.4 1047.5 720.6 799.5 806.0 818.1 822.8 4643.4 4702.6 4741.8 4885.9 4899.4 408.3 408.9 414.1 421.1 426.9 3239.7 3254.6 3378.1 3390.7 3506.9 8920.8 8936.5 8943.8 9002.3 9011.5 8992.6 9050.0 9074.6 9077.9 9103.8 6757.9 6990.2 7016.6 7026.4 7171.7 4906.4 4966.8 5052.3 5055.8 5115.5 8196.1 8453.8 8709.0 8709.0 8750.9 8605.3 8783.6 8804.4 8829.2 8915.8 5900.6 6440.4 6647.2 6770.6 6803.0 7357.2 7402.7 7430.5 7437.2 7440.8 6336.8 6615.5 6668.4 6713.4 6768.3 6173.1 6605.1 6632.0 6657.6 6673.1 5925.8 6064.2 6103.4 6111.5 6112.2 3788.8 3926.6 3976.3 4009.4 4062.7 4148.0 4179.9 4241.7 4305.5 4380.1 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | [#4] prototype.html Cycles:180 Average:4251.18 Median:4856.76 stddev:1221.57 (25.2%) stddev-sans-first:1188.39 01:56:59 INFO - PROCESS | 27861 | Values: 296.7 301.8 302.1 307.7 308.6 4850.9 4852.9 4863.8 4878.9 4882.9 4824.1 4831.2 4852.0 4860.6 4889.2 3629.7 3713.5 3737.3 3819.5 3857.5 3803.7 3813.7 3824.0 3832.3 3840.3 3645.0 3786.3 3788.0 3790.2 3799.6 3732.2 3786.2 3797.6 3798.4 3810.6 3373.7 3394.6 3396.7 3398.4 3399.6 4720.0 4724.0 4734.1 4747.6 4763.9 4207.2 4340.7 4342.4 4361.6 4374.9 5044.7 5059.3 5065.7 5072.5 5079.6 3660.8 3680.6 3693.1 3694.0 3708.9 5197.4 5274.9 5296.8 5315.4 5315.8 3747.4 3776.0 3790.2 3793.0 3803.0 3838.2 3851.5 3864.9 3867.7 3881.9 4328.8 4334.6 4361.5 4379.5 4394.6 4899.0 5067.8 5086.7 5104.6 5110.9 1288.5 1321.2 1323.8 1325.1 1328.3 861.8 863.3 911.5 936.2 942.2 4504.6 4506.3 4507.2 4512.9 4547.6 5182.9 5185.6 5186.3 5226.0 5240.8 4323.6 4474.1 4479.6 4494.0 4580.5 2827.4 2842.9 2849.8 2851.9 2860.4 4965.3 4991.8 5000.0 5010.2 5010.3 5060.6 5379.3 5383.7 5458.2 5463.0 4934.5 4935.0 4954.7 4973.8 4981.0 5247.9 5290.2 5307.4 5329.2 5333.1 4870.2 5122.9 5162.0 5162.2 5207.9 4893.4 4944.4 4946.5 4950.7 4965.6 3769.0 3780.9 3794.1 3797.4 3799.5 5166.0 5234.7 5254.2 5258.3 5340.8 5030.5 5068.4 5079.4 5097.8 5102.0 5113.5 5118.3 5121.1 5129.9 5138.9 4805.5 4889.6 5012.4 5030.2 5055.2 5042.6 5173.5 5175.6 5176.9 5178.8 5047.0 5098.2 5119.3 5128.9 5132.8 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - PROCESS | 27861 | [#5] yui.html Cycles:180 Average:17648.16 Median:2301.35 stddev:25278.91 (1098.4%) stddev-sans-first:25317.44 01:56:59 INFO - PROCESS | 27861 | Values: 606.6 608.0 622.1 623.7 656.5 13028.7 13052.2 13428.5 13449.9 13640.1 12878.5 12933.2 12995.7 13048.2 13068.7 626.8 738.2 761.5 768.5 787.3 799.3 802.0 802.1 802.1 802.1 833.8 834.0 834.9 835.0 835.2 649.3 798.5 823.1 826.0 828.4 607.0 608.5 610.7 611.1 611.2 13062.9 13091.5 13101.1 13106.6 13115.9 12648.7 13020.3 13026.2 13063.3 13470.1 11564.7 11633.9 11647.5 11770.9 11984.2 4158.1 4186.1 4217.9 4252.9 4283.1 58811.0 59443.4 60008.4 60940.1 61329.0 10277.7 10339.8 10349.2 10520.4 10529.5 18499.6 18555.0 18563.6 18582.4 18611.4 6565.1 6635.8 6830.3 6925.0 7141.6 3764.3 3768.8 3785.6 3834.7 3938.7 2673.5 2766.1 2770.0 2771.1 2772.3 416.6 497.7 519.7 520.0 544.1 527.7 533.4 552.3 556.9 567.8 7391.3 7567.7 7595.5 8006.7 8066.3 581.7 596.9 599.7 614.9 615.7 3623.3 3706.3 3765.6 3778.7 3785.9 99700.0 100053.5 100191.5 102018.0 102712.0 86760.0 90432.0 90636.5 90852.5 91053.5 59333.0 61425.7 78607.0 80642.0 81171.2 8324.4 8405.9 8475.7 8588.7 8676.4 35704.5 41486.8 42225.9 42238.2 42839.4 38670.2 52903.0 54845.2 54937.2 56170.0 11541.5 11553.5 11674.0 11904.2 12211.9 12708.7 12756.7 12894.8 13214.6 13345.3 11848.2 12096.5 12342.9 12748.4 13093.1 11840.8 12071.2 12409.5 12530.5 13107.6 12302.7 12419.1 12560.1 13008.8 13023.5 9940.4 9978.8 10125.6 10244.6 10618.6 9886.3 10651.9 10690.0 10762.6 10762.7 01:56:59 INFO - PROCESS | 27861 | -------- Summary: end -------- 01:56:59 INFO - PROCESS | 27861 | 01:56:59 INFO - TEST-INFO | 27861: exit 0 01:56:59 INFO - TEST-OK | dromaeo_css | took 1120313ms 01:56:59 INFO - TEST-START | kraken 01:56:59 INFO - operating with platform_type : linux_ 01:56:59 INFO - Initialising browser for kraken test... 01:56:59 INFO - TEST-INFO | started process 28038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo2jWCJ/profile http://localhost:44698/getInfo.html) 01:57:04 INFO - PROCESS | 28038 | __metrics Screen width/height:1600/1200 01:57:04 INFO - PROCESS | 28038 | colorDepth:24 01:57:04 INFO - PROCESS | 28038 | Browser inner width/height: 1024/697 01:57:04 INFO - PROCESS | 28038 | __metrics 01:57:05 INFO - PROCESS | 28038 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:57:05 INFO - PROCESS | 28038 | console.error: PushService: 01:57:05 INFO - PROCESS | 28038 | stateChangeProcessEnqueue: Error transitioning state 01:57:05 INFO - PROCESS | 28038 | UnknownError 01:57:06 INFO - TEST-INFO | 28038: exit 0 01:57:06 INFO - Browser initialized. 01:57:06 INFO - Running cycle 1/1 for kraken test... 01:57:06 INFO - TEST-INFO | started process 28118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo2jWCJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:18 INFO - PROCESS | 28118 | RSS: Main: 175869952 01:57:18 INFO - PROCESS | 28118 | 01:57:21 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44698/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:22 INFO - PROCESS | 28118 | RSS: Main: 234393600 01:57:22 INFO - PROCESS | 28118 | 01:57:24 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44698/tests/kraken/driver.html?testName=audio-dft) 01:57:25 INFO - PROCESS | 28118 | RSS: Main: 221102080 01:57:25 INFO - PROCESS | 28118 | 01:57:28 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44698/tests/kraken/driver.html?testName=audio-fft) 01:57:29 INFO - PROCESS | 28118 | RSS: Main: 289124352 01:57:29 INFO - PROCESS | 28118 | 01:57:31 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44698/tests/kraken/driver.html?testName=audio-oscillator) 01:57:32 INFO - PROCESS | 28118 | RSS: Main: 199299072 01:57:32 INFO - PROCESS | 28118 | 01:57:34 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44698/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:35 INFO - PROCESS | 28118 | RSS: Main: 202973184 01:57:35 INFO - PROCESS | 28118 | 01:57:38 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44698/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:38 INFO - PROCESS | 28118 | RSS: Main: 239280128 01:57:38 INFO - PROCESS | 28118 | 01:57:42 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44698/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:43 INFO - PROCESS | 28118 | RSS: Main: 234872832 01:57:43 INFO - PROCESS | 28118 | 01:57:45 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44698/tests/kraken/driver.html?testName=json-parse-financial) 01:57:46 INFO - PROCESS | 28118 | RSS: Main: 237957120 01:57:46 INFO - PROCESS | 28118 | 01:57:48 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44698/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:48 INFO - PROCESS | 28118 | RSS: Main: 227684352 01:57:48 INFO - PROCESS | 28118 | 01:57:50 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:51 INFO - PROCESS | 28118 | RSS: Main: 232730624 01:57:51 INFO - PROCESS | 28118 | 01:57:53 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:57:54 INFO - PROCESS | 28118 | RSS: Main: 239906816 01:57:54 INFO - PROCESS | 28118 | 01:57:57 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:57:57 INFO - PROCESS | 28118 | RSS: Main: 239722496 01:57:57 INFO - PROCESS | 28118 | 01:58:00 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:01 INFO - PROCESS | 28118 | RSS: Main: 239157248 01:58:01 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | Cycle 1(1): loaded http://localhost:44698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44698/tests/kraken/driver.html?testName=ai-astar) 01:58:03 INFO - PROCESS | 28118 | RSS: Main: 282656768 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | __start_tp_report 01:58:03 INFO - PROCESS | 28118 | _x_x_mozilla_page_load 01:58:03 INFO - PROCESS | 28118 | _x_x_mozilla_page_load_details 01:58:03 INFO - PROCESS | 28118 | |i|pagename|runs| 01:58:03 INFO - PROCESS | 28118 | |0;ai-astar;112;107;114;115;113;113;112;113;112;112 01:58:03 INFO - PROCESS | 28118 | |1;audio-beat-detection;173;133;133;176;131;152;158;131;188;131 01:58:03 INFO - PROCESS | 28118 | |2;audio-dft;161;162;160;162;160;160;161;160;163;160 01:58:03 INFO - PROCESS | 28118 | |3;audio-fft;76;75;76;133;76;76;74;75;105;76 01:58:03 INFO - PROCESS | 28118 | |4;audio-oscillator;87;86;117;87;87;86;114;87;88;120 01:58:03 INFO - PROCESS | 28118 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;117 01:58:03 INFO - PROCESS | 28118 | |6;imaging-darkroom;145;147;147;147;147;147;146;147;147;147 01:58:03 INFO - PROCESS | 28118 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;96 01:58:03 INFO - PROCESS | 28118 | |8;json-parse-financial;64;63;63;63;63;79;64;63;63;64 01:58:03 INFO - PROCESS | 28118 | |9;json-stringify-tinderbox;66;66;65;66;66;66;66;65;66;71 01:58:03 INFO - PROCESS | 28118 | |10;stanford-crypto-aes;90;83;84;90;87;91;85;90;118;83 01:58:03 INFO - PROCESS | 28118 | |11;stanford-crypto-ccm;144;136;134;132;131;143;127;130;147;145 01:58:03 INFO - PROCESS | 28118 | |12;stanford-crypto-pbkdf2;172;171;175;170;172;171;170;168;166;169 01:58:03 INFO - PROCESS | 28118 | |13;stanford-crypto-sha256-iterative;69;68;73;68;71;67;67;69;66;67 01:58:03 INFO - PROCESS | 28118 | __end_tp_report 01:58:03 INFO - PROCESS | 28118 | __start_cc_report 01:58:03 INFO - PROCESS | 28118 | _x_x_mozilla_cycle_collect,1938 01:58:03 INFO - PROCESS | 28118 | __end_cc_report 01:58:03 INFO - PROCESS | 28118 | __startTimestamp1466067483297__endTimestamp 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | ------- Summary: start ------- 01:58:03 INFO - PROCESS | 28118 | Number of tests: 14 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.11 (1.9%) stddev-sans-first:2.24 01:58:03 INFO - PROCESS | 28118 | Values: 112.0 107.0 114.0 115.0 113.0 113.0 112.0 113.0 112.0 112.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:155.00 stddev:22.05 (14.2%) stddev-sans-first:21.84 01:58:03 INFO - PROCESS | 28118 | Values: 173.0 133.0 133.0 176.0 131.0 152.0 158.0 131.0 188.0 131.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 01:58:03 INFO - PROCESS | 28118 | Values: 161.0 162.0 160.0 162.0 160.0 160.0 161.0 160.0 163.0 160.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:19.50 (25.7%) stddev-sans-first:20.46 01:58:03 INFO - PROCESS | 28118 | Values: 76.0 75.0 76.0 133.0 76.0 76.0 74.0 75.0 105.0 76.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:87.00 stddev:14.64 (16.8%) stddev-sans-first:15.17 01:58:03 INFO - PROCESS | 28118 | Values: 87.0 86.0 117.0 87.0 87.0 86.0 114.0 87.0 88.0 120.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:58:03 INFO - PROCESS | 28118 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.33 01:58:03 INFO - PROCESS | 28118 | Values: 145.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:58:03 INFO - PROCESS | 28118 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:63.50 stddev:4.98 (7.8%) stddev-sans-first:5.27 01:58:03 INFO - PROCESS | 28118 | Values: 64.0 63.0 63.0 63.0 63.0 79.0 64.0 63.0 63.0 64.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.80 01:58:03 INFO - PROCESS | 28118 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 71.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:88.50 stddev:10.29 (11.6%) stddev-sans-first:10.91 01:58:03 INFO - PROCESS | 28118 | Values: 90.0 83.0 84.0 90.0 87.0 91.0 85.0 90.0 118.0 83.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:139.50 stddev:7.22 (5.2%) stddev-sans-first:7.18 01:58:03 INFO - PROCESS | 28118 | Values: 144.0 136.0 134.0 132.0 131.0 143.0 127.0 130.0 147.0 145.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:2.46 (1.4%) stddev-sans-first:2.54 01:58:03 INFO - PROCESS | 28118 | Values: 172.0 171.0 175.0 170.0 172.0 171.0 170.0 168.0 166.0 169.0 01:58:03 INFO - PROCESS | 28118 | 01:58:03 INFO - PROCESS | 28118 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.12 (3.1%) stddev-sans-first:2.24 01:58:03 INFO - PROCESS | 28118 | Values: 69.0 68.0 73.0 68.0 71.0 67.0 67.0 69.0 66.0 67.0 01:58:03 INFO - PROCESS | 28118 | -------- Summary: end -------- 01:58:03 INFO - PROCESS | 28118 | 01:58:04 INFO - TEST-INFO | 28118: exit 0 01:58:04 INFO - TEST-OK | kraken | took 64371ms 01:58:04 INFO - SUITE-END | took 1184s 01:58:04 INFO - Completed test suite (00:19:44) 01:58:04 INFO - javascript benchmark 01:58:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2606.0487921908502, 2627.68467783866, 2649.0728245114205, 2661.334666333417, 2668.1862032080207, 4610.861674149781, 4682.157211701892, 4685.0, 4749.073930583538, 4792.305115758213, 4727.432708075027, 4739.14695354836, 4849.248366503198, 4858.46556878743, 4866.0, 4346.391505189268, 4352.586504282104, 4410.051838854645, 4470.0, 4569.634429245652, 4467.30756732707, 4518.164139634162, 4535.841245556406, 4547.272436410175, 4569.1547063793305, 4272.914541709149, 4308.009157893702, 4309.2458819706735, 4317.11499142675, 4430.357598148251, 4327.2643650579475, 4337.219300525904, 4344.087741574273, 4355.5644435556505, 4399.406080179167, 4383.123375324948, 4390.692651514395, 4397.318415645548, 4397.626201772853, 4434.157510073108, 4556.977215113903, 4695.413073365829, 4761.095391875567, 4782.713037217778, 4824.541668541483, 5126.92309615356, 5186.273921650972, 5192.247124167013, 5194.480551944813, 5198.376194856603, 5185.662931909414, 5187.948120518822, 5219.817306394296, 5224.817131400421, 5228.451012643655, 4645.883852903637, 4734.242521196592, 4761.571458568746, 4769.070031343855, 4872.780724867425, 5201.609879259071, 5272.2882410874045, 5302.893942121136, 5321.627486076015, 5322.92015619766, 5027.622928280321, 5040.899182016339, 5045.268436076748, 5096.9490305097215, 5107.182850743863, 5019.0965626187635, 5030.471800460972, 5072.239164125337, 5083.0, 5115.335006449138, 5038.546530812245, 5073.492650734897, 5077.416097148875, 5088.313077734532, 5125.589952803767, 4923.433805112386, 5070.264811602297, 5076.974615126975, 5082.695038297714, 5090.185570308733, 4270.48754149504, 4304.80628371724, 4372.322290045048, 4380.430544029319, 4430.401895744098, 3822.2928758179823, 3822.961770382316, 3830.4254361845387, 3872.361060425055, 3873.4189871518934, 4422.867313980586, 4425.668074894332, 4426.0483995940385, 4464.308032255006, 4473.172463094338, 4957.90084198314, 5009.073321435546, 5011.398632164163, 5020.648554601216, 5133.409657889316, 4337.457817772778, 4353.586409291175, 4354.695171337976, 4362.345648152803, 4415.668824838086, 4580.679352445297, 4592.334111553806, 4593.425821772278, 4597.218472859622, 4635.281531362644, 4716.080364328923, 4767.976160119178, 4791.47293797682, 4798.1123492154065, 4799.640026998059, 5126.7180305083575, 5167.354080739908, 5173.611979101507, 5174.120399532164, 5190.714510701797, 4803.03939212152, 4836.540528649773, 4849.709017458964, 4851.56335929768, 4883.560479556857, 4813.374261346003, 4984.077945580079, 5005.199168133081, 5045.949540504548, 5141.254518094781, 5123.231515272739, 5130.153524668388, 5135.87160320995, 5141.532064608934, 5148.176291793295, 5005.599552035901, 5006.924896126488, 5008.298838162587, 5012.122878496176, 5043.470435604356, 4864.075825593126, 4942.629302802232, 4979.975100124476, 4999.47505511916, 5027.446980832178, 4905.141600219876, 4958.801647934187, 4990.076835785391, 4994.900101998012, 4995.100881841304, 4867.026594681149, 5018.347614810197, 5026.447090819934, 5030.798768049237, 5055.317532133115, 4835.105505481497, 4839.95160048395, 4851.151048566416, 4873.561379475864, 4878.926816097833], "value": 4693.7970979589745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.5007011046672, 588.2558563417276, 591.0926727473329, 594.5629961977943, 608.3490664988461, 26287.211383658472, 26859.865700671493, 39665.40501892474, 39689.20621587567, 40854.0, 37521.249575008485, 42524.36213456801, 42555.14889702204, 42588.14823703524, 42629.57370426295, 7828.334591559725, 7867.7246296379635, 7921.405894557903, 7922.683092676286, 7975.561344126071, 7599.354054905312, 10017.549210285519, 10247.795044099114, 10248.74378140545, 10607.257491975564, 10073.345232559861, 10161.339512931672, 10161.593536258577, 10164.237682173829, 10168.59325626974, 10178.287519873611, 10219.437930913797, 10257.384556926609, 10258.794824103476, 10270.89729102707, 10052.195824334109, 10158.187345012382, 10158.542865571068, 10162.18702503798, 10164.339317944385, 38876.222475550334, 39084.0, 39107.41338879919, 39136.80431597852, 39210.607893920984, 3111.222194451387, 3144.166795799115, 3250.398676244902, 3539.309834582232, 3715.6623615498397, 29216.561751573532, 29865.70134298651, 30738.38523229523, 31213.37573248545, 31221.0, 3582.265635544707, 3595.8381872815785, 3597.1546686528905, 3643.7995910224927, 3702.666759991587, 219565.0, 220589.0, 220972.0, 221108.0, 221578.0, 52276.21585676218, 52841.73579132157, 52964.0, 52969.735151324, 53001.2049819253, 56794.43205567974, 56800.715996419756, 56847.43152568422, 56872.715636421555, 56995.15024248771, 13289.800652990212, 13769.793453098211, 13772.724545509034, 13778.448862045607, 13784.655383615489, 9645.08371704687, 10011.149052330487, 10156.4921753912, 10190.745231369276, 10214.336068155546, 16551.25519351632, 16645.33418663264, 16699.582510437336, 16724.080175590218, 16736.0, 5818.156367326714, 5913.556483263773, 5928.4960778334325, 6053.697315134225, 6053.7578496860515, 821.3839620284787, 856.3235044314921, 930.1628534319167, 969.4231932000589, 1033.813913495563, 27342.863285683445, 27582.44835103287, 27600.723992759817, 27610.0, 28012.0, 967.7967626798311, 979.4368238262884, 1024.8513965474965, 1036.76154484469, 1046.2362475392854, 14325.0, 14818.851811481747, 14902.403903843942, 15091.773623395438, 15205.847941520664, 366420.0, 369922.0, 369926.0, 369950.0, 370333.0, 46497.76751116223, 47501.76249118801, 47560.5243947563, 47560.7621961888, 47844.28233576499, 1096.950637221327, 1128.08061429936, 1190.7618476304601, 1192.65413030222, 1209.3348658237935, 27375.315617109733, 28498.715012849607, 28568.57147142836, 28918.855405722836, 29304.26739331534, 41154.0, 41521.0, 41664.3750343739, 41698.374524382765, 41721.0, 295632.0, 297768.0, 298363.0, 299001.0, 299223.0, 30877.228069298446, 31949.36101278008, 36094.278114438086, 37079.814600926824, 37113.62886371102, 40673.59326406698, 41061.48323684333, 41326.586734132274, 41834.372484412146, 42356.57643423526, 34906.825465872505, 35387.646123538434, 35418.64581354154, 36003.27993440169, 36110.819445902605, 35078.824605876805, 35118.12204694903, 35185.296294074484, 35481.29037419289, 35760.28479430449, 34908.82545587256, 34994.125146871535, 35184.64815351814, 35357.46963795597, 35693.64306357007, 31249.531257031616, 31996.6800332003, 32139.196520087185, 32166.356672865943, 32369.838150809097, 24651.876740616182, 24846.25461236166, 24886.626700599143, 25291.620625690997, 25311.114111006027], "value": 17894.556208501363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.5975945978343, 374.9418840079788, 377.6186052087391, 388.94165875118745, 391.5770967355257, 16038.83961160388, 16221.18894055297, 17211.22549485273, 17238.74141887871, 18077.548061298476, 11067.667969960894, 15647.921760391182, 16595.751063734053, 16617.750733739005, 17414.129293535338, 3524.365614189445, 4574.771261436923, 4776.211925032366, 4779.617630589544, 4780.426348838144, 3676.4301533262387, 5225.0, 5567.137093750455, 5578.135389014709, 5654.9717251413895, 5185.611079169059, 5640.153976903456, 5642.7178641067985, 5645.350784659776, 5646.2942132233475, 3482.3035392921265, 5431.158170483562, 5486.890262194774, 5518.448155184489, 5532.612717109804, 5096.51583099605, 5412.729363531807, 5422.484863937959, 5493.121100623921, 5504.80733174337, 12279.263244205376, 12697.238165710087, 12734.745305093846, 16188.35246590135, 20121.597568048557, 1951.2780271299569, 1988.7514060742408, 2043.5402034542258, 2180.095260466904, 2429.817763667732, 8915.420497667696, 9020.8646870297, 9323.766905827408, 9368.484733339663, 11326.546938122548, 1698.1678977301158, 1730.1522254095528, 1732.5322163015915, 1768.4341010876524, 1788.6601545706274, 63487.0, 64763.99670518904, 65859.67070164667, 65960.34039659638, 67203.0, 9631.136276180625, 9800.55897484615, 9865.112139907444, 9937.900620993698, 10533.0, 13571.52499662507, 13601.0, 13604.93197534006, 13667.316634168252, 13674.93162534181, 6544.934550654432, 6754.797356079325, 6780.93219067803, 6815.386615204557, 6869.828254293682, 6275.497960163176, 6314.242290925118, 6344.936550634435, 6365.649889256136, 6382.712777925005, 4267.103908179255, 4279.079997800488, 4285.37862010013, 4320.243957307459, 4371.75955322454, 1580.2809721576884, 1670.741035139531, 1780.9554761130817, 1791.6954117800005, 1864.0334447158107, 803.1446509467398, 837.7905523619095, 876.268315956171, 938.9530673299222, 943.3585162089845, 15434.536963891102, 15751.13368764706, 15971.0, 16403.67192656164, 16407.671846563, 835.511225932824, 836.9748907532784, 856.4561503445357, 866.8093019535692, 889.6174644902625, 8377.6230069647, 8686.826263474695, 9129.45223286605, 9168.312376571785, 9256.537173141316, 360301.0, 365402.0, 383825.0, 385895.0, 387273.0, 71665.0, 72501.0, 73933.26066739371, 73987.0, 76813.6159319211, 842.1872892658614, 860.4966094834592, 862.2670729879677, 868.2186032570611, 870.9520976346362, 14691.884326969008, 14882.255887205813, 14984.0, 15158.690677544435, 15342.76985845191, 35732.82133589315, 36213.45679814752, 36508.0, 36796.0, 38578.6142138575, 47291.52708472871, 48747.268790968876, 48927.26609100795, 49143.262851057974, 49151.50848491612, 7437.256274372519, 7642.465027448247, 7645.885311720217, 7696.384289256734, 7829.7259595913865, 6698.894682377353, 8589.742307730778, 11123.72190695239, 11416.0, 11496.0, 9892.258080644124, 10047.849282260626, 10059.144972677404, 10244.436555989492, 10262.384256944608, 9965.651202208179, 9992.10071093605, 10022.3485473444, 10063.849042264519, 10086.848697269694, 10001.34991225568, 10089.949550252202, 10290.948545257226, 10303.278770485995, 10312.123469505175, 10964.780704385708, 11111.277766945122, 11186.496607652512, 11386.373749443861, 11487.253328533952, 9883.159931405911, 10166.8474972874, 10882.45587720595, 11091.0, 11244.10047196206], "value": 8009.8390554017815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.660734994202, 1361.8025386318984, 1399.8600139986, 1451.194587004213, 1630.2745278351138, 7029.89455158173, 7349.889751653723, 7369.852602947938, 7540.0, 7555.924440755591, 7418.480706350544, 7556.168821429638, 7564.62176891156, 7571.6214189290595, 7584.203658615848, 2162.0703097667997, 2186.431527802775, 2187.3000639795273, 2188.0919418441326, 2189.35414052854, 2181.7600063993027, 2205.2502149269244, 2213.070510385634, 2225.4658881868318, 2226.5101677630896, 2164.83763717721, 2166.144372972675, 2193.0898677049004, 2195.2316689158824, 2198.692183094368, 2085.0, 2119.6078725435846, 2119.7774233705395, 2121.8302535797175, 2123.4797474618663, 2083.406229224679, 2114.534802343482, 2133.136079887648, 2140.336495686342, 2146.61360955028, 7312.890306645405, 7500.774976750707, 7556.735514256975, 7566.394688424913, 7582.582957937311, 4440.800163992628, 4543.204939135671, 4550.13547425988, 4553.0, 4555.339475775994, 2699.7030326664053, 2832.3202431416516, 2859.628248327725, 2864.398476319975, 2866.7133286671374, 926.0785518409226, 934.4159900062461, 937.8124375125002, 941.9387739796891, 953.918916892065, 9863.704088877344, 9907.058829411195, 9981.351212171257, 9982.151517120981, 10001.0, 3749.1189570450924, 3842.8078596070086, 3931.7837518936735, 3951.4665520154986, 3969.384745364473, 7844.058712954482, 7922.564258965812, 7947.324477419368, 7961.522308661499, 7968.7609371718945, 4384.386185933972, 4390.736555806662, 4400.361947517592, 4401.163778882003, 4404.911901761947, 3653.0, 4013.7190396671954, 4025.0943537703783, 4085.8978525536504, 4106.281400754856, 3264.4450443424676, 3298.191942973987, 3388.0852169913987, 3398.864045438155, 3399.9150021249666, 1005.8491226316111, 1030.7886883188928, 1032.7573020340214, 1041.3855825063097, 1047.4553232319151, 720.6180724216174, 799.5043073294595, 805.9717909873126, 818.0878320672407, 822.7531740477953, 4643.442786865598, 4702.576768090888, 4741.83403580873, 4885.853424397203, 4899.412070551485, 408.28957613752453, 408.8793805827288, 414.0621492319898, 421.1303657946331, 426.9231538323132, 3239.6922292382187, 3254.5769050023346, 3378.138574663445, 3390.71178949792, 3506.859725610998, 8920.776980575538, 8936.50849203287, 8943.776405589782, 9002.279817614575, 9011.459312441275, 8992.55037248148, 9050.049744776836, 9074.637014519345, 9077.863832042525, 9103.772405689911, 6757.898631520531, 6990.161180658353, 7016.649167541705, 7026.367626913602, 7171.7489887852635, 4906.386701662293, 4966.826161084345, 5052.267421223975, 5055.848324550269, 5115.514026167508, 8196.098429172667, 8453.830923381622, 8709.0, 8709.0, 8750.912490875264, 8605.268552173135, 8783.560821958748, 8804.427712198687, 8829.205371516595, 8915.777105572413, 5900.64596124234, 6440.355964403522, 6647.169103862017, 6770.5599136056, 6803.0, 7357.153927298429, 7402.703891844266, 7430.517016393917, 7437.219091995263, 7440.776776696708, 6336.778212762531, 6615.536912416277, 6668.366505182, 6713.362230588086, 6768.323167683192, 6173.135760993554, 6605.141331626858, 6631.966840165961, 6657.600543967377, 6673.099131617364, 5925.762969481172, 6064.151018857452, 6103.389661033861, 6111.541634377529, 6112.205413296243, 3788.791616461121, 3926.587708290588, 3976.3439032559304, 4009.3985902114914, 4062.6749860010536, 4147.983743982743, 4179.895502612459, 4241.681873859535, 4305.547917468621, 4380.0582874682095], "value": 3874.7518879398453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6855133558428, 301.83700801567153, 302.0997427665557, 307.6631088957592, 308.6111499510616, 4850.9029819403595, 4852.927206091911, 4863.781129849156, 4878.877518388225, 4882.926756098661, 4824.118593748441, 4831.227003679403, 4852.0, 4860.586850117736, 4889.24216746404, 3629.6914762245174, 3713.535808023997, 3737.3085979093817, 3819.484369610109, 3857.498525191721, 3803.7147213958924, 3813.675837553811, 3824.0, 3832.2527107213964, 3840.347140986039, 3645.0, 3786.2995345861104, 3787.9810600946957, 3790.2040571479884, 3799.620037996206, 3732.216234590739, 3786.2238241160494, 3797.620237976208, 3798.4112462568346, 3810.5617853946874, 3373.6795004474534, 3394.6435624259343, 3396.6603339666085, 3398.4052790761516, 3399.55805745254, 4719.952800471986, 4723.976380118112, 4734.088535550612, 4747.572718455321, 4763.857084287477, 4207.158568286355, 4340.674449416275, 4342.370356298351, 4361.6074553290355, 4374.868753937387, 5044.672096313728, 5059.342285502861, 5065.670731402447, 5072.503611434636, 5079.619028572872, 3660.7803531788177, 3680.589214064792, 3693.0582701411236, 3694.039549717066, 3708.8516459341595, 5197.428282888879, 5274.894502109936, 5296.841094767202, 5315.362156541201, 5315.840524784263, 3747.437884317374, 3775.981120094437, 3790.1851102013197, 3792.981035094862, 3803.0, 3838.2323535292494, 3851.5378154621626, 3864.9227015460096, 3867.690584753213, 3881.8835434936996, 4328.761918094535, 4334.609885110355, 4361.454818147731, 4379.4525684289465, 4394.604485596312, 4898.9712160446, 5067.822626208139, 5086.745662716849, 5104.617153713486, 5110.8756073663735, 1288.4910460368103, 1321.1808678619318, 1323.7551053055215, 1325.0923117664238, 1328.2561765411401, 861.814709837388, 863.2662237098542, 911.5168960450972, 936.2089034765612, 942.1520631431766, 4504.572065653823, 4506.324051392317, 4507.211238033331, 4512.887177820581, 4547.590247023433, 5182.870428239325, 5185.585153187736, 5186.273921650972, 5226.0, 5240.790368385298, 4323.589259020388, 4474.127545128668, 4479.641628669699, 4494.011317510142, 4580.450345958507, 2827.3638431353193, 2842.9431411371656, 2849.8147620404607, 2851.918099787167, 2860.3707184419395, 4965.318727886973, 4991.825286115041, 5000.0, 5010.198368261061, 5010.298558201855, 5060.569851562658, 5379.28346185174, 5383.650062745909, 5458.153986132156, 5462.9726851365485, 4934.506549345108, 4934.9753251233515, 4954.711774938614, 4973.8010479581135, 4981.003799240167, 5247.868803279948, 5290.206469029523, 5307.363116426053, 5329.227262047059, 5333.146696528692, 4870.245112007645, 5122.923156152735, 5162.045021671003, 5162.174052151638, 5207.895842083213, 4893.437254715754, 4944.381952255968, 4946.505349465025, 4950.653454258311, 4965.577925876341, 3768.9811550942068, 3780.905477363088, 3794.1083845296885, 3797.3544497436055, 3799.544054713452, 5165.992631436834, 5234.685918844882, 5254.238135470412, 5258.263843062051, 5340.839774806762, 5030.4718004608985, 5068.442471328225, 5079.415867175175, 5097.7706003229205, 5102.0, 5113.463086375877, 5118.334616499831, 5121.0795951518185, 5129.897402052013, 5138.871528211825, 4805.471398146131, 4889.63327750413, 5012.448630650699, 5030.220315851049, 5055.241713742968, 5042.647014709082, 5173.499685091281, 5175.585953123817, 5176.870578235575, 5178.818741344186, 5047.0, 5098.1842905135, 5119.334486516878, 5128.923066154085, 5132.8460146195675], "value": 3865.1888246045005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.5935822998591, 608.0484042473529, 622.1259130921055, 623.691272819954, 656.5207398599019, 13028.739425211503, 13052.216866987976, 13428.462861485528, 13449.865501344984, 13640.113392629484, 12878.484860605588, 12933.224006559612, 12995.740085198291, 13048.151870128435, 13068.73862522749, 626.7618305044077, 738.2322384719912, 761.5012167030604, 768.4966347042696, 787.2953706432739, 799.2526987266895, 802.0295442514564, 802.0856223904754, 802.1016461563057, 802.1256830055239, 833.7623777223492, 833.9583020848934, 834.870595057767, 834.9791255218607, 835.1606635331483, 649.3182158733312, 798.4690181029638, 823.1151512124491, 825.9958700206461, 828.3828547731918, 607.0439058482907, 608.4615115622662, 610.6854969690613, 611.0864257934417, 611.2420598457925, 13062.934685326607, 13091.47634094635, 13101.08292419531, 13106.60680179596, 13115.934420327838, 12648.747025059447, 13020.348982550835, 13026.153300035467, 13063.34683265833, 13470.057096003284, 11564.653060408116, 11633.883661163449, 11647.534098636044, 11770.882291177064, 11984.161108722394, 4158.147579746144, 4186.0581369192, 4217.894552636178, 4252.936205956913, 4283.100548884738, 58811.0, 59443.40556594465, 60008.399916000715, 60940.08589871156, 61329.0, 10277.7430564235, 10339.793204135874, 10349.223808214414, 10520.421376824348, 10529.526171322308, 18499.630007399777, 18555.0, 18563.628727425377, 18582.44252672422, 18611.441656750318, 6565.080888675589, 6635.767748128792, 6830.316968303229, 6925.0, 7141.571505709674, 3764.284785890672, 3768.8304026318883, 3785.602511736228, 3834.654881060718, 3938.6849052075763, 2673.5454972654697, 2766.073365422606, 2769.9723002770115, 2771.0993926973815, 2772.348498102944, 416.63336264088014, 497.7312251384212, 519.7011718262014, 519.9714015729171, 544.0913674164156, 527.7123967437756, 533.4230618879604, 552.2985808023788, 556.8552176434156, 567.8410045187354, 7391.2978267064545, 7567.735129270449, 7595.468317217852, 8006.719764808204, 8066.274035336848, 581.7236812514022, 596.8895754285471, 599.6851652882272, 614.8862460444832, 615.722924683894, 3623.3115708015393, 3706.3328600852105, 3765.642263984917, 3778.7165962552917, 3785.905352366158, 99700.0, 100053.49973250087, 100191.49904250578, 102018.0, 102712.0, 86760.0, 90432.0, 90636.5468172655, 90852.54573727089, 91053.54473227591, 59333.0, 61425.69287153625, 78607.0, 80642.0, 81171.18828811754, 8324.417290789586, 8405.915940840758, 8475.74572762818, 8588.742337729878, 8676.436031657922, 35704.464433033005, 41486.79256603698, 42225.94435139146, 42238.155236895705, 42839.3574096395, 38670.2265954685, 52903.0, 54845.177322341, 54937.1759423617, 56170.0, 11541.480633371351, 11553.480093395985, 11674.0, 11904.226225295328, 12211.938940305241, 12708.682282943, 12756.74486510246, 12894.806577901527, 13214.603561893158, 13345.266010369134, 11848.170628055954, 12096.455659495168, 12342.938285308515, 12748.362581871055, 13093.083484156017, 11840.822387664364, 12071.215371000857, 12409.503619855104, 12530.498780048696, 13107.606771796862, 12302.692432688897, 12419.068569857116, 12560.12079154487, 13008.804867927178, 13023.479060837839, 9940.353876997971, 9978.800423991624, 10125.594976201164, 10244.59021639156, 10618.575256989634, 9886.30795844284, 10651.89348106509, 10690.0, 10762.569497220024, 10762.748714257981], "value": 6601.904244073262, "unit": "score"}], "name": "dromaeo_css", "value": 6365.523460366471, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 114.0, 115.0, 113.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 133.0, 133.0, 176.0, 131.0, 152.0, 158.0, 131.0, 188.0, 131.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 162.0, 160.0, 160.0, 161.0, 160.0, 163.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 133.0, 76.0, 76.0, 74.0, 75.0, 105.0, 76.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 117.0, 87.0, 87.0, 86.0, 114.0, 87.0, 88.0, 120.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 79.0, 64.0, 63.0, 63.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 71.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 84.0, 90.0, 87.0, 91.0, 85.0, 90.0, 118.0, 83.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 136.0, 134.0, 132.0, 131.0, 143.0, 127.0, 130.0, 147.0, 145.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 175.0, 170.0, 172.0, 171.0, 170.0, 168.0, 166.0, 169.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 73.0, 68.0, 71.0, 67.0, 67.0, 69.0, 66.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1559.7, "alertThreshold": 2.0}]} 01:58:04 INFO - Return code: 0 01:58:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:58:04 INFO - # TBPL SUCCESS # 01:58:04 INFO - Running post-action listener: _resource_record_post_action 01:58:04 INFO - ##### 01:58:04 INFO - ##### Finished run-tests step (success) 01:58:04 INFO - ##### 01:58:04 INFO - Running post-run listener: _resource_record_post_run 01:58:04 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551530496; Read time: 16; Write time: 458352 01:58:04 INFO - TinderboxPrint: CPU usage
13.1% 01:58:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:58:04 INFO - TinderboxPrint: I/O write bytes / time
551,530,496 / 458,352 01:58:04 INFO - TinderboxPrint: CPU idle
8,331.2 (86.8%) 01:58:04 INFO - TinderboxPrint: CPU user
1,213.5 (12.7%) 01:58:04 INFO - TinderboxPrint: Swap in / out
0 / 0 01:58:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 254894080; Read time: 0; Write time: 246772 01:58:04 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296636416; Read time: 16; Write time: 211580 01:58:05 INFO - Running post-run listener: _upload_blobber_files 01:58:05 INFO - Blob upload gear active. 01:58:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:58:05 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 01:58:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:58:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:58:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:58:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:58:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:06 INFO - (blobuploader) - INFO - Done attempting. 01:58:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:58:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:10 INFO - (blobuploader) - INFO - Done attempting. 01:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:11 INFO - (blobuploader) - INFO - Done attempting. 01:58:11 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:11 INFO - Return code: 0 01:58:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1c463dc1a400352501e2e64228114e29a22bc167930e97cede7dbee0df7989234bbc280427761bec910b3826740fe621dd2bd218f933a82dfc36d83f8edb49b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9d8a146e5a215e2ea546fb0baa8609ca466fb4487035b79943429a8a1135ed58c96cce6efcf27fef88c0e4ca2d4c3e3721a30b992af2ccb46219866a79fadcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1564410d7b739925dcbd91cfb0cf66df22c8aa041446939fe02b2f9543438063a1dadad13dcb7b3855968540384e13d7890ebdfa2252f97c7c18e4f264795945"} 01:58:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:11 INFO - Contents: 01:58:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1c463dc1a400352501e2e64228114e29a22bc167930e97cede7dbee0df7989234bbc280427761bec910b3826740fe621dd2bd218f933a82dfc36d83f8edb49b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9d8a146e5a215e2ea546fb0baa8609ca466fb4487035b79943429a8a1135ed58c96cce6efcf27fef88c0e4ca2d4c3e3721a30b992af2ccb46219866a79fadcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1564410d7b739925dcbd91cfb0cf66df22c8aa041446939fe02b2f9543438063a1dadad13dcb7b3855968540384e13d7890ebdfa2252f97c7c18e4f264795945"} 01:58:11 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:11 INFO - Copying logs to upload dir... 01:58:11 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.431817 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-16 01:58:10.800799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 01:58:10.804081) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514 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-Non-PGO/sha512/e1c463dc1a400352501e2e64228114e29a22bc167930e97cede7dbee0df7989234bbc280427761bec910b3826740fe621dd2bd218f933a82dfc36d83f8edb49b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9d8a146e5a215e2ea546fb0baa8609ca466fb4487035b79943429a8a1135ed58c96cce6efcf27fef88c0e4ca2d4c3e3721a30b992af2ccb46219866a79fadcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1564410d7b739925dcbd91cfb0cf66df22c8aa041446939fe02b2f9543438063a1dadad13dcb7b3855968540384e13d7890ebdfa2252f97c7c18e4f264795945"} build_url:https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/U_m1AeMcSIyxFfctq4qV5Q/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-Non-PGO/sha512/e1c463dc1a400352501e2e64228114e29a22bc167930e97cede7dbee0df7989234bbc280427761bec910b3826740fe621dd2bd218f933a82dfc36d83f8edb49b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9d8a146e5a215e2ea546fb0baa8609ca466fb4487035b79943429a8a1135ed58c96cce6efcf27fef88c0e4ca2d4c3e3721a30b992af2ccb46219866a79fadcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1564410d7b739925dcbd91cfb0cf66df22c8aa041446939fe02b2f9543438063a1dadad13dcb7b3855968540384e13d7890ebdfa2252f97c7c18e4f264795945"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 01:58:10.830252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:58:10.830762) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466065605.330405-1563228514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:58:10.913511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 01:58:10.913906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 01:58:10.914259) ========= ========= Total master_lag: 0.20 =========