builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1465303225.53 results: success (0) buildid: 20160607030217 builduid: 92ce1efff5eb4b16bb84399bd9484775 revision: 1828937da9493b2cd54862b9c520b2ba5c7db92b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.525815) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.526210) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.526476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.543754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.544030) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 05:40: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2016-06-07 05:40:25 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156554 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.731769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.732078) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013797 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.781325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:25.781681) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1828937da9493b2cd54862b9c520b2ba5c7db92b --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 1828937da9493b2cd54862b9c520b2ba5c7db92b --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=9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 05:40:25,548 truncating revision to first 12 chars 2016-06-07 05:40:25,548 Setting DEBUG logging. 2016-06-07 05:40:25,548 attempt 1/10 2016-06-07 05:40:25,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1828937da949?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 05:40:25,849 unpacking tar archive at: mozilla-central-1828937da949/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:26.449981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:26.450294) ========= script_repo_revision: 1828937da9493b2cd54862b9c520b2ba5c7db92b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:26.450698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:26.450962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 05:40:26.461006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-07 05:40:26.461450) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:40:26 INFO - MultiFileLogger online at 20160607 05:40:26 in /builds/slave/test 05:40:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:40:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:40:26 INFO - {'append_to_log': False, 05:40:26 INFO - 'base_work_dir': '/builds/slave/test', 05:40:26 INFO - 'blob_upload_branch': 'Firefox', 05:40:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:40:26 INFO - 'branch': 'Firefox', 05:40:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:26 INFO - 'config_files': ('talos/linux_config.py',), 05:40:26 INFO - 'default_actions': ('clobber', 05:40:26 INFO - 'read-buildbot-config', 05:40:26 INFO - 'download-and-extract', 05:40:26 INFO - 'populate-webroot', 05:40:26 INFO - 'create-virtualenv', 05:40:26 INFO - 'install', 05:40:26 INFO - 'run-tests'), 05:40:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:26 INFO - 'download_minidump_stackwalk': True, 05:40:26 INFO - 'download_symbols': 'ondemand', 05:40:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:26 INFO - 'installer_path': 'installer.exe', 05:40:26 INFO - 'log_level': 'info', 05:40:26 INFO - 'log_name': 'talos', 05:40:26 INFO - 'log_to_console': True, 05:40:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:40:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:40:26 INFO - 'opt_config_files': (), 05:40:26 INFO - 'pip_index': False, 05:40:26 INFO - 'sps_profile': False, 05:40:26 INFO - 'sps_profile_interval': 0, 05:40:26 INFO - 'suite': 'dromaeojs', 05:40:26 INFO - 'system_bits': '32', 05:40:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:26 INFO - 'title': 'talos-linux64-ix-022', 05:40:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:26 INFO - 'use_talos_json': True, 05:40:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:40:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:26 INFO - 'work_dir': 'build'} 05:40:26 INFO - ##### 05:40:26 INFO - ##### Running clobber step. 05:40:26 INFO - ##### 05:40:26 INFO - Running pre-action listener: _resource_record_pre_action 05:40:26 INFO - Running main action method: clobber 05:40:26 INFO - rmtree: /builds/slave/test/build 05:40:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:40:27 INFO - Running post-action listener: _resource_record_post_action 05:40:27 INFO - ##### 05:40:27 INFO - ##### Finished clobber step (success) 05:40:27 INFO - ##### 05:40:27 INFO - ##### 05:40:27 INFO - ##### Running read-buildbot-config step. 05:40:27 INFO - ##### 05:40:27 INFO - Running pre-action listener: _resource_record_pre_action 05:40:27 INFO - Running main action method: read_buildbot_config 05:40:27 INFO - Using buildbot properties: 05:40:27 INFO - { 05:40:27 INFO - "project": "", 05:40:27 INFO - "product": "firefox", 05:40:27 INFO - "script_repo_revision": "production", 05:40:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:40:27 INFO - "repository": "", 05:40:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:40:27 INFO - "buildid": "20160607030217", 05:40:27 INFO - "stage_platform": "linux64-pgo", 05:40:27 INFO - "basedir": "/builds/slave/test", 05:40:27 INFO - "nightly_build": "True", 05:40:27 INFO - "buildnumber": 326, 05:40:27 INFO - "slavename": "talos-linux64-ix-022", 05:40:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:40:27 INFO - "platform": "ubuntu64_hw", 05:40:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:40:27 INFO - "branch": "mozilla-central", 05:40:27 INFO - "repo_path": "mozilla-central", 05:40:27 INFO - "revision": "1828937da9493b2cd54862b9c520b2ba5c7db92b", 05:40:27 INFO - "pgo_build": "True", 05:40:27 INFO - "builduid": "92ce1efff5eb4b16bb84399bd9484775", 05:40:27 INFO - "slavebuilddir": "test" 05:40:27 INFO - } 05:40:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:40:27 INFO - Running post-action listener: _resource_record_post_action 05:40:27 INFO - ##### 05:40:27 INFO - ##### Finished read-buildbot-config step (success) 05:40:27 INFO - ##### 05:40:27 INFO - ##### 05:40:27 INFO - ##### Running download-and-extract step. 05:40:27 INFO - ##### 05:40:27 INFO - Running pre-action listener: _resource_record_pre_action 05:40:27 INFO - Running main action method: download_and_extract 05:40:27 INFO - mkdir: /builds/slave/test/build/tests 05:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:27 INFO - https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:40:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:40:33 INFO - Downloaded 1361 bytes. 05:40:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:33 INFO - Using the following test package requirements: 05:40:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:40:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:40:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'jsshell-linux-x86_64.zip'], 05:40:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:40:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:40:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:40:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:40:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:40:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:33 INFO - https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:40:41 INFO - Downloaded 24442840 bytes. 05:40:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:40:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:40:42 INFO - Return code: 0 05:40:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:42 INFO - https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:40:44 INFO - Downloaded 24442840 bytes. 05:40:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:40:46 INFO - Return code: 0 05:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:46 INFO - https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:40:48 INFO - Downloaded 10833369 bytes. 05:40:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:40:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:40:48 INFO - Return code: 0 05:40: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')]} 05:40:48 INFO - https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:40:51 INFO - Downloaded 59194600 bytes. 05:40:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:51 INFO - mkdir: /builds/slave/test/properties 05:40:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:51 INFO - Contents: 05:40:51 INFO - build_url:https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:51 INFO - Running post-action listener: _resource_record_post_action 05:40:52 INFO - Running post-action listener: set_extra_try_arguments 05:40:52 INFO - ##### 05:40:52 INFO - ##### Finished download-and-extract step (success) 05:40:52 INFO - ##### 05:40:52 INFO - ##### 05:40:52 INFO - ##### Running populate-webroot step. 05:40:52 INFO - ##### 05:40:52 INFO - Running pre-action listener: _resource_record_pre_action 05:40:52 INFO - Running main action method: populate_webroot 05:40:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:52 INFO - '--tppagecycles', 05:40:52 INFO - '7'], 05:40:52 INFO - 'tests': ['tsvgm']}}, 05:40:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['damp', 'tps']}, 05:40:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'tests': ['damp', 'tps']}, 05:40:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['dromaeo_dom']}, 05:40:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['a11yr', 05:40:52 INFO - 'ts_paint', 05:40:52 INFO - 'tpaint', 05:40:52 INFO - 'sessionrestore', 05:40:52 INFO - 'sessionrestore_no_auto_restore', 05:40:52 INFO - 'tabpaint']}, 05:40:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:52 INFO - 'ts_paint', 05:40:52 INFO - 'tpaint', 05:40:52 INFO - 'sessionrestore', 05:40:52 INFO - 'sessionrestore_no_auto_restore', 05:40:52 INFO - 'tabpaint']}, 05:40:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:52 INFO - 'ts_paint', 05:40:52 INFO - 'tpaint', 05:40:52 INFO - 'sessionrestore', 05:40:52 INFO - 'sessionrestore_no_auto_restore', 05:40:52 INFO - 'tabpaint']}, 05:40:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:52 INFO - 'ts_paint', 05:40:52 INFO - 'tpaint', 05:40:52 INFO - 'sessionrestore', 05:40:52 INFO - 'sessionrestore_no_auto_restore', 05:40:52 INFO - 'tabpaint']}, 05:40:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['a11yr', 05:40:52 INFO - 'ts_paint', 05:40:52 INFO - 'tpaint', 05:40:52 INFO - 'sessionrestore', 05:40:52 INFO - 'sessionrestore_no_auto_restore', 05:40:52 INFO - 'tabpaint']}, 05:40:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['a11yr', 05:40:52 INFO - 'ts_paint', 05:40:52 INFO - 'tpaint', 05:40:52 INFO - 'sessionrestore', 05:40:52 INFO - 'sessionrestore_no_auto_restore', 05:40:52 INFO - 'tabpaint']}, 05:40:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['tsvgx', 05:40:52 INFO - 'tsvgr_opacity', 05:40:52 INFO - 'tart', 05:40:52 INFO - 'tscrollx', 05:40:52 INFO - 'cart']}, 05:40:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:52 INFO - 'tsvgr_opacity', 05:40:52 INFO - 'tart', 05:40:52 INFO - 'tscrollx', 05:40:52 INFO - 'cart']}, 05:40:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'talos_options': ['--disable-e10s'], 05:40:52 INFO - 'tests': ['tp5o']}, 05:40:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'tests': ['tp5o']}, 05:40:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'talos_options': ['--disable-e10s', 05:40:52 INFO - '--xperf_path', 05:40:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:52 INFO - 'tests': ['tp5n']}, 05:40:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:52 INFO - 'talos_options': ['--xperf_path', 05:40:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:52 INFO - 'tests': ['tp5n']}}, 05:40:52 INFO - 'talos.zip': {'path': '', 05:40:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:52 INFO - Running post-action listener: _resource_record_post_action 05:40:52 INFO - ##### 05:40:52 INFO - ##### Finished populate-webroot step (success) 05:40:52 INFO - ##### 05:40:52 INFO - ##### 05:40:52 INFO - ##### Running create-virtualenv step. 05:40:52 INFO - ##### 05:40:52 INFO - Running pre-action listener: _resource_record_pre_action 05:40:52 INFO - Running main action method: create_virtualenv 05:40:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:40:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:52 INFO - Using real prefix '/usr' 05:40:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:55 INFO - Installing pip.................done. 05:40:55 INFO - Return code: 0 05:40:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:40:55 INFO - Using env: {'DISPLAY': ':0', 05:40:55 INFO - 'HOME': '/home/cltbld', 05:40:55 INFO - 'LANG': 'en_US.UTF-8', 05:40:55 INFO - 'LANGUAGE': 'en_US:en', 05:40:55 INFO - 'LOGNAME': 'cltbld', 05:40:55 INFO - 'MAIL': '/var/mail/cltbld', 05:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:55 INFO - 'MOZ_NO_REMOTE': '1', 05:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:55 INFO - 'NO_EM_RESTART': '1', 05:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:55 INFO - 'PWD': '/builds/slave/test', 05:40:55 INFO - 'SHELL': '/bin/bash', 05:40:55 INFO - 'SHLVL': '1', 05:40:55 INFO - 'TERM': 'linux', 05:40:55 INFO - 'TMOUT': '86400', 05:40:55 INFO - 'USER': 'cltbld', 05:40:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:55 INFO - '_': '/tools/buildbot/bin/python'} 05:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:40:55 INFO - Cleaning up... 05:40:55 INFO - Return code: 0 05:40:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:40:55 INFO - Using env: {'DISPLAY': ':0', 05:40:55 INFO - 'HOME': '/home/cltbld', 05:40:55 INFO - 'LANG': 'en_US.UTF-8', 05:40:55 INFO - 'LANGUAGE': 'en_US:en', 05:40:55 INFO - 'LOGNAME': 'cltbld', 05:40:55 INFO - 'MAIL': '/var/mail/cltbld', 05:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:55 INFO - 'MOZ_NO_REMOTE': '1', 05:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:55 INFO - 'NO_EM_RESTART': '1', 05:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:55 INFO - 'PWD': '/builds/slave/test', 05:40:55 INFO - 'SHELL': '/bin/bash', 05:40:55 INFO - 'SHLVL': '1', 05:40:55 INFO - 'TERM': 'linux', 05:40:55 INFO - 'TMOUT': '86400', 05:40:55 INFO - 'USER': 'cltbld', 05:40:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:55 INFO - '_': '/tools/buildbot/bin/python'} 05:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:55 INFO - Downloading/unpacking psutil>=3.1.1 05:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:57 INFO - Installing collected packages: psutil 05:40:57 INFO - Running setup.py install for psutil 05:40:57 INFO - building 'psutil._psutil_linux' extension 05:40:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:40:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:40:59 INFO - building 'psutil._psutil_posix' extension 05:40:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:40:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:59 INFO - Successfully installed psutil 05:40:59 INFO - Cleaning up... 05:40:59 INFO - Return code: 0 05:40:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:40: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 mozsystemmonitor==0.3 05:40:59 INFO - Using env: {'DISPLAY': ':0', 05:40:59 INFO - 'HOME': '/home/cltbld', 05:40:59 INFO - 'LANG': 'en_US.UTF-8', 05:40:59 INFO - 'LANGUAGE': 'en_US:en', 05:40:59 INFO - 'LOGNAME': 'cltbld', 05:40:59 INFO - 'MAIL': '/var/mail/cltbld', 05:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:59 INFO - 'MOZ_NO_REMOTE': '1', 05:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:59 INFO - 'NO_EM_RESTART': '1', 05:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:59 INFO - 'PWD': '/builds/slave/test', 05:40:59 INFO - 'SHELL': '/bin/bash', 05:40:59 INFO - 'SHLVL': '1', 05:40:59 INFO - 'TERM': 'linux', 05:40:59 INFO - 'TMOUT': '86400', 05:40:59 INFO - 'USER': 'cltbld', 05:40:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:59 INFO - '_': '/tools/buildbot/bin/python'} 05:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:41:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:41:01 INFO - Installing collected packages: mozsystemmonitor 05:41:01 INFO - Running setup.py install for mozsystemmonitor 05:41:01 INFO - Successfully installed mozsystemmonitor 05:41:01 INFO - Cleaning up... 05:41:02 INFO - Return code: 0 05:41:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 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 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:41:02 INFO - Using env: {'DISPLAY': ':0', 05:41:02 INFO - 'HOME': '/home/cltbld', 05:41:02 INFO - 'LANG': 'en_US.UTF-8', 05:41:02 INFO - 'LANGUAGE': 'en_US:en', 05:41:02 INFO - 'LOGNAME': 'cltbld', 05:41:02 INFO - 'MAIL': '/var/mail/cltbld', 05:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:02 INFO - 'MOZ_NO_REMOTE': '1', 05:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:02 INFO - 'NO_EM_RESTART': '1', 05:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:02 INFO - 'PWD': '/builds/slave/test', 05:41:02 INFO - 'SHELL': '/bin/bash', 05:41:02 INFO - 'SHLVL': '1', 05:41:02 INFO - 'TERM': 'linux', 05:41:02 INFO - 'TMOUT': '86400', 05:41:02 INFO - 'USER': 'cltbld', 05:41:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:02 INFO - '_': '/tools/buildbot/bin/python'} 05:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:04 INFO - warning: no files found matching '*.txt' 05:41:04 INFO - no previously-included directories found matching 'build' 05:41:04 INFO - no previously-included directories found matching 'dist' 05:41:04 INFO - no previously-included directories found matching '.git*' 05:41:04 INFO - Installing collected packages: jsonschema, functools32 05:41:04 INFO - Running setup.py install for functools32 05:41:04 INFO - warning: no files found matching '*.txt' 05:41:04 INFO - no previously-included directories found matching 'build' 05:41:04 INFO - no previously-included directories found matching 'dist' 05:41:04 INFO - no previously-included directories found matching '.git*' 05:41:04 INFO - Successfully installed jsonschema functools32 05:41:04 INFO - Cleaning up... 05:41:04 INFO - Return code: 0 05:41:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:04 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 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:41:04 INFO - Using env: {'DISPLAY': ':0', 05:41:04 INFO - 'HOME': '/home/cltbld', 05:41:04 INFO - 'LANG': 'en_US.UTF-8', 05:41:04 INFO - 'LANGUAGE': 'en_US:en', 05:41:04 INFO - 'LOGNAME': 'cltbld', 05:41:04 INFO - 'MAIL': '/var/mail/cltbld', 05:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:04 INFO - 'MOZ_NO_REMOTE': '1', 05:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:04 INFO - 'NO_EM_RESTART': '1', 05:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:04 INFO - 'PWD': '/builds/slave/test', 05:41:04 INFO - 'SHELL': '/bin/bash', 05:41:04 INFO - 'SHLVL': '1', 05:41:04 INFO - 'TERM': 'linux', 05:41:04 INFO - 'TMOUT': '86400', 05:41:04 INFO - 'USER': 'cltbld', 05:41:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:04 INFO - '_': '/tools/buildbot/bin/python'} 05:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:41:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:07 INFO - Downloading docopt-0.6.1.tar.gz 05:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:07 INFO - Running setup.py install for blobuploader 05:41:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:41:07 INFO - Running setup.py install for requests 05:41:08 INFO - Running setup.py install for docopt 05:41:08 INFO - Successfully installed blobuploader requests docopt 05:41:08 INFO - Cleaning up... 05:41:08 INFO - Return code: 0 05:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:08 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 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:08 INFO - Using env: {'DISPLAY': ':0', 05:41:08 INFO - 'HOME': '/home/cltbld', 05:41:08 INFO - 'LANG': 'en_US.UTF-8', 05:41:08 INFO - 'LANGUAGE': 'en_US:en', 05:41:08 INFO - 'LOGNAME': 'cltbld', 05:41:08 INFO - 'MAIL': '/var/mail/cltbld', 05:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:08 INFO - 'MOZ_NO_REMOTE': '1', 05:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:08 INFO - 'NO_EM_RESTART': '1', 05:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:08 INFO - 'PWD': '/builds/slave/test', 05:41:08 INFO - 'SHELL': '/bin/bash', 05:41:08 INFO - 'SHLVL': '1', 05:41:08 INFO - 'TERM': 'linux', 05:41:08 INFO - 'TMOUT': '86400', 05:41:08 INFO - 'USER': 'cltbld', 05:41:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:08 INFO - '_': '/tools/buildbot/bin/python'} 05:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:08 INFO - Running setup.py (path:/tmp/pip-ajqmMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:08 INFO - Running setup.py (path:/tmp/pip-WyOBkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:08 INFO - Running setup.py (path:/tmp/pip-N7dMiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:08 INFO - Running setup.py (path:/tmp/pip-YMsjye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:08 INFO - Running setup.py (path:/tmp/pip-uQRluW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:08 INFO - Running setup.py (path:/tmp/pip-xsgIoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:09 INFO - Running setup.py (path:/tmp/pip-pRBYLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:09 INFO - Running setup.py (path:/tmp/pip-yoZbst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:09 INFO - Running setup.py (path:/tmp/pip-gGF4Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:09 INFO - Running setup.py (path:/tmp/pip-pBdiVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:09 INFO - Running setup.py (path:/tmp/pip-hIBMsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:09 INFO - Running setup.py (path:/tmp/pip-J70nZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:09 INFO - Running setup.py (path:/tmp/pip-9lquqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:09 INFO - Running setup.py (path:/tmp/pip-7ywroP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:09 INFO - Running setup.py (path:/tmp/pip-beeLfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:09 INFO - Running setup.py (path:/tmp/pip-woWlDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:09 INFO - Running setup.py (path:/tmp/pip-9dEeP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:09 INFO - Running setup.py install for manifestparser 05:41:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:41:09 INFO - Running setup.py install for mozcrash 05:41:09 INFO - Running setup.py install for mozdebug 05:41:10 INFO - Running setup.py install for mozdevice 05:41:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Running setup.py install for mozfile 05:41:10 INFO - Running setup.py install for mozhttpd 05:41:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Running setup.py install for mozinfo 05:41:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Running setup.py install for mozInstall 05:41:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Running setup.py install for mozleak 05:41:10 INFO - Running setup.py install for mozlog 05:41:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Running setup.py install for moznetwork 05:41:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:10 INFO - Running setup.py install for mozprocess 05:41:11 INFO - Running setup.py install for mozprofile 05:41:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:11 INFO - Running setup.py install for mozrunner 05:41:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:11 INFO - Running setup.py install for mozscreenshot 05:41:11 INFO - Running setup.py install for moztest 05:41:11 INFO - Running setup.py install for mozversion 05:41:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:11 INFO - Cleaning up... 05:41:11 INFO - Return code: 0 05:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:11 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 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:11 INFO - Using env: {'DISPLAY': ':0', 05:41:11 INFO - 'HOME': '/home/cltbld', 05:41:11 INFO - 'LANG': 'en_US.UTF-8', 05:41:11 INFO - 'LANGUAGE': 'en_US:en', 05:41:11 INFO - 'LOGNAME': 'cltbld', 05:41:11 INFO - 'MAIL': '/var/mail/cltbld', 05:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:11 INFO - 'MOZ_NO_REMOTE': '1', 05:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:11 INFO - 'NO_EM_RESTART': '1', 05:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:11 INFO - 'PWD': '/builds/slave/test', 05:41:11 INFO - 'SHELL': '/bin/bash', 05:41:11 INFO - 'SHLVL': '1', 05:41:11 INFO - 'TERM': 'linux', 05:41:11 INFO - 'TMOUT': '86400', 05:41:11 INFO - 'USER': 'cltbld', 05:41:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:11 INFO - '_': '/tools/buildbot/bin/python'} 05:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:11 INFO - Running setup.py (path:/tmp/pip-CVSpeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:11 INFO - Running setup.py (path:/tmp/pip-NQ5t6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:11 INFO - Running setup.py (path:/tmp/pip-HjLvzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:12 INFO - Running setup.py (path:/tmp/pip-CSJOqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:12 INFO - Running setup.py (path:/tmp/pip-HJpcbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:12 INFO - Running setup.py (path:/tmp/pip-XeOtg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:12 INFO - Running setup.py (path:/tmp/pip-t8gtvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:12 INFO - Running setup.py (path:/tmp/pip-PeEXny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:12 INFO - Running setup.py (path:/tmp/pip-464AHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:12 INFO - Running setup.py (path:/tmp/pip-Ehj7QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:12 INFO - Running setup.py (path:/tmp/pip-cKYvUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:12 INFO - Running setup.py (path:/tmp/pip-eBjxFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:12 INFO - Running setup.py (path:/tmp/pip-DtnqqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:12 INFO - Running setup.py (path:/tmp/pip-WUGpeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:12 INFO - Running setup.py (path:/tmp/pip-p_W5mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:12 INFO - Running setup.py (path:/tmp/pip-czXaso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:12 INFO - Running setup.py (path:/tmp/pip-GvvvWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:41:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:14 INFO - Downloading blessings-1.6.tar.gz 05:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:14 INFO - Installing collected packages: blessings 05:41:14 INFO - Running setup.py install for blessings 05:41:15 INFO - Successfully installed blessings 05:41:15 INFO - Cleaning up... 05:41:15 INFO - Return code: 0 05:41:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:41:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:15 INFO - Reading from file tmpfile_stdout 05:41:15 INFO - Current package versions: 05:41:15 INFO - argparse == 1.2.1 05:41:15 INFO - blessings == 1.6 05:41:15 INFO - blobuploader == 1.2.4 05:41:15 INFO - docopt == 0.6.1 05:41:15 INFO - functools32 == 3.2.3-2 05:41:15 INFO - jsonschema == 2.5.1 05:41:15 INFO - manifestparser == 1.1 05:41:15 INFO - mozInstall == 1.12 05:41:15 INFO - mozcrash == 0.17 05:41:15 INFO - mozdebug == 0.1 05:41:15 INFO - mozdevice == 0.48 05:41:15 INFO - mozfile == 1.2 05:41:15 INFO - mozhttpd == 0.7 05:41:15 INFO - mozinfo == 0.9 05:41:15 INFO - mozleak == 0.1 05:41:15 INFO - mozlog == 3.2 05:41:15 INFO - moznetwork == 0.27 05:41:15 INFO - mozprocess == 0.22 05:41:15 INFO - mozprofile == 0.28 05:41:15 INFO - mozrunner == 6.11 05:41:15 INFO - mozscreenshot == 0.1 05:41:15 INFO - mozsystemmonitor == 0.3 05:41:15 INFO - moztest == 0.7 05:41:15 INFO - mozversion == 1.4 05:41:15 INFO - psutil == 3.1.1 05:41:15 INFO - requests == 1.2.3 05:41:15 INFO - wsgiref == 0.1.2 05:41:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:15 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 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:15 INFO - Using env: {'DISPLAY': ':0', 05:41:15 INFO - 'HOME': '/home/cltbld', 05:41:15 INFO - 'LANG': 'en_US.UTF-8', 05:41:15 INFO - 'LANGUAGE': 'en_US:en', 05:41:15 INFO - 'LOGNAME': 'cltbld', 05:41:15 INFO - 'MAIL': '/var/mail/cltbld', 05:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:15 INFO - 'MOZ_NO_REMOTE': '1', 05:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:15 INFO - 'NO_EM_RESTART': '1', 05:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:15 INFO - 'PWD': '/builds/slave/test', 05:41:15 INFO - 'SHELL': '/bin/bash', 05:41:15 INFO - 'SHLVL': '1', 05:41:15 INFO - 'TERM': 'linux', 05:41:15 INFO - 'TMOUT': '86400', 05:41:15 INFO - 'USER': 'cltbld', 05:41:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:15 INFO - '_': '/tools/buildbot/bin/python'} 05:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:41:15 INFO - Cleaning up... 05:41:15 INFO - Return code: 0 05:41:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:41:15 INFO - Using env: {'DISPLAY': ':0', 05:41:15 INFO - 'HOME': '/home/cltbld', 05:41:15 INFO - 'LANG': 'en_US.UTF-8', 05:41:15 INFO - 'LANGUAGE': 'en_US:en', 05:41:15 INFO - 'LOGNAME': 'cltbld', 05:41:15 INFO - 'MAIL': '/var/mail/cltbld', 05:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:15 INFO - 'MOZ_NO_REMOTE': '1', 05:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:15 INFO - 'NO_EM_RESTART': '1', 05:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:15 INFO - 'PWD': '/builds/slave/test', 05:41:15 INFO - 'SHELL': '/bin/bash', 05:41:15 INFO - 'SHLVL': '1', 05:41:15 INFO - 'TERM': 'linux', 05:41:15 INFO - 'TMOUT': '86400', 05:41:15 INFO - 'USER': 'cltbld', 05:41:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:15 INFO - '_': '/tools/buildbot/bin/python'} 05:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:41:15 INFO - Cleaning up... 05:41:15 INFO - Return code: 0 05:41:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef46c71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:41:15 INFO - Using env: {'DISPLAY': ':0', 05:41:15 INFO - 'HOME': '/home/cltbld', 05:41:15 INFO - 'LANG': 'en_US.UTF-8', 05:41:15 INFO - 'LANGUAGE': 'en_US:en', 05:41:15 INFO - 'LOGNAME': 'cltbld', 05:41:15 INFO - 'MAIL': '/var/mail/cltbld', 05:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:15 INFO - 'MOZ_NO_REMOTE': '1', 05:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:15 INFO - 'NO_EM_RESTART': '1', 05:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:15 INFO - 'PWD': '/builds/slave/test', 05:41:15 INFO - 'SHELL': '/bin/bash', 05:41:15 INFO - 'SHLVL': '1', 05:41:15 INFO - 'TERM': 'linux', 05:41:15 INFO - 'TMOUT': '86400', 05:41:15 INFO - 'USER': 'cltbld', 05:41:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:15 INFO - '_': '/tools/buildbot/bin/python'} 05:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:16 INFO - Downloading/unpacking flake8 05:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:41:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:41:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:41:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:18 INFO - no previously-included directories found matching 'docs/_build' 05:41:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:41:18 INFO - Running setup.py install for pep8 05:41:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:18 INFO - no previously-included directories found matching 'docs/_build' 05:41:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:41:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:41:18 INFO - Cleaning up... 05:41:18 INFO - Return code: 0 05:41:18 INFO - Running post-action listener: _resource_record_post_action 05:41:18 INFO - Running post-action listener: _start_resource_monitoring 05:41:18 INFO - Starting resource monitoring. 05:41:18 INFO - ##### 05:41:18 INFO - ##### Finished create-virtualenv step (success) 05:41:18 INFO - ##### 05:41:18 INFO - ##### 05:41:18 INFO - ##### Running install step. 05:41:18 INFO - ##### 05:41:18 INFO - Running pre-action listener: _resource_record_pre_action 05:41:18 INFO - Running main action method: install 05:41:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:19 INFO - Reading from file tmpfile_stdout 05:41:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:19 INFO - Reading from file tmpfile_stdout 05:41:19 INFO - Output received: 05:41:19 INFO - Usage: mozinstall [options] installer 05:41:19 INFO - Options: 05:41:19 INFO - -h, --help show this help message and exit 05:41:19 INFO - -d DEST, --destination=DEST 05:41:19 INFO - Directory to install application into. [default: 05:41:19 INFO - "/builds/slave/test"] 05:41:19 INFO - --app=APP Application being installed. [default: firefox] 05:41:19 INFO - mkdir: /builds/slave/test/build/application 05:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:41:35 INFO - Reading from file tmpfile_stdout 05:41:35 INFO - Output received: 05:41:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:41:36 INFO - Running post-action listener: _resource_record_post_action 05:41:36 INFO - ##### 05:41:36 INFO - ##### Finished install step (success) 05:41:36 INFO - ##### 05:41:36 INFO - ##### 05:41:36 INFO - ##### Running run-tests step. 05:41:36 INFO - ##### 05:41:36 INFO - Running pre-action listener: _resource_record_pre_action 05:41:36 INFO - Running main action method: run_tests 05:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:36 INFO - Python 2.7.3 05:41:36 INFO - Return code: 0 05:41:36 INFO - grabbing minidump binary from tooltool 05:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:36 INFO - 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 0x2d361c0>, '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 0x2d370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d37550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:41:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:41:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:41:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:36 INFO - Return code: 0 05:41:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:41:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:41:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:41:37 INFO - Return code: 0 05:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:41:37 INFO - Using env: {'DISPLAY': ':0', 05:41:37 INFO - 'HOME': '/home/cltbld', 05:41:37 INFO - 'LANG': 'en_US.UTF-8', 05:41:37 INFO - 'LANGUAGE': 'en_US:en', 05:41:37 INFO - 'LOGNAME': 'cltbld', 05:41:37 INFO - 'MAIL': '/var/mail/cltbld', 05:41:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:37 INFO - 'MOZ_NO_REMOTE': '1', 05:41:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:37 INFO - 'NO_EM_RESTART': '1', 05:41:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:37 INFO - 'PWD': '/builds/slave/test', 05:41:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:37 INFO - 'SHELL': '/bin/bash', 05:41:37 INFO - 'SHLVL': '1', 05:41:37 INFO - 'TERM': 'linux', 05:41:37 INFO - 'TMOUT': '86400', 05:41:37 INFO - 'USER': 'cltbld', 05:41:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084', 05:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:37 INFO - '_': '/tools/buildbot/bin/python'} 05:41:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:41:37 INFO - mozversion application_buildid: 20160607030217 05:41:37 INFO - mozversion application_changeset: 1828937da9493b2cd54862b9c520b2ba5c7db92b 05:41:37 INFO - mozversion application_display_name: Nightly 05:41:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:37 INFO - mozversion application_name: Firefox 05:41:37 INFO - mozversion application_remotingname: firefox 05:41:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:41:37 INFO - mozversion application_vendor: Mozilla 05:41:37 INFO - mozversion application_version: 50.0a1 05:41:37 INFO - mozversion platform_buildid: 20160607030217 05:41:37 INFO - mozversion platform_changeset: 1828937da9493b2cd54862b9c520b2ba5c7db92b 05:41:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:41:37 INFO - mozversion platform_version: 50.0a1 05:41:37 INFO - using testdate: 1465303297 05:41:37 INFO - actual date: 1465303297 05:41:37 INFO - starting webserver on 'localhost:38411' 05:41:37 INFO - SUITE-START | Running 2 tests 05:41:37 INFO - TEST-START | dromaeo_css 05:41:37 INFO - operating with platform_type : linux_ 05:41:37 INFO - Initialising browser for dromaeo_css test... 05:41:37 INFO - TEST-INFO | started process 3278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk4x9iz/profile http://localhost:38411/getInfo.html) 05:41:44 INFO - PROCESS | 3278 | __metrics Screen width/height:1600/1200 05:41:44 INFO - PROCESS | 3278 | colorDepth:24 05:41:44 INFO - PROCESS | 3278 | Browser inner width/height: 1024/697 05:41:44 INFO - PROCESS | 3278 | __metrics 05:41:45 ERROR - PROCESS | 3278 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:41:45 INFO - PROCESS | 3278 | console.error: PushService: 05:41:45 INFO - PROCESS | 3278 | stateChangeProcessEnqueue: Error transitioning state 05:41:45 INFO - PROCESS | 3278 | UnknownError 05:41:46 INFO - TEST-INFO | 3278: exit 0 05:41:46 INFO - Browser initialized. 05:41:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:46 INFO - TEST-INFO | started process 3362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk4x9iz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:58 INFO - PROCESS | 3362 | RSS: Main: 160284672 05:41:58 INFO - PROCESS | 3362 | 05:42:49 INFO - PROCESS | 3362 | 1465303369630 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:44:57 INFO - PROCESS | 3362 | Cycle 1(1): loaded http://localhost:38411/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38411/tests/dromaeo/cssquery-ext.html) 05:44:58 INFO - PROCESS | 3362 | RSS: Main: 249991168 05:44:58 INFO - PROCESS | 3362 | 05:48:01 INFO - PROCESS | 3362 | Cycle 1(1): loaded http://localhost:38411/tests/dromaeo/cssquery-ext.html (next: http://localhost:38411/tests/dromaeo/cssquery-jquery.html) 05:48:01 INFO - PROCESS | 3362 | RSS: Main: 244903936 05:48:01 INFO - PROCESS | 3362 | 05:51:04 INFO - PROCESS | 3362 | Cycle 1(1): loaded http://localhost:38411/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38411/tests/dromaeo/cssquery-mootools.html) 05:51:04 INFO - PROCESS | 3362 | RSS: Main: 247709696 05:51:04 INFO - PROCESS | 3362 | 05:54:06 INFO - PROCESS | 3362 | Cycle 1(1): loaded http://localhost:38411/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38411/tests/dromaeo/cssquery-prototype.html) 05:54:07 INFO - PROCESS | 3362 | RSS: Main: 248377344 05:54:07 INFO - PROCESS | 3362 | 05:57:09 INFO - PROCESS | 3362 | Cycle 1(1): loaded http://localhost:38411/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38411/tests/dromaeo/cssquery-yui.html) 05:57:10 INFO - PROCESS | 3362 | RSS: Main: 229371904 05:57:10 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | Cycle 1(1): loaded http://localhost:38411/tests/dromaeo/cssquery-yui.html (next: http://localhost:38411/tests/dromaeo/cssquery-dojo.html) 06:00:13 INFO - PROCESS | 3362 | RSS: Main: 279789568 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | __start_tp_report 06:00:13 INFO - PROCESS | 3362 | _x_x_mozilla_page_load 06:00:13 INFO - PROCESS | 3362 | _x_x_mozilla_page_load_details 06:00:13 INFO - PROCESS | 3362 | |i|pagename|runs| 06:00:13 INFO - PROCESS | 3362 | |0;dojo.html;3176.936461270773;3177.031005543309;3177.7298929590984;3214.903552893414;3233.110894504013;5297.4437684043105;5335.439778823216;5473.397926228112;5544.695041772701;5578.86052848679;5499.1476321170185;5520.06158952978;5528.944710552893;5569.387367389584;5615.157726341051;4933.062718083562;4987.700737955734;5027.798888044492;5033.949660503385;5174.922376164361;5044.646874718771;5076.64463487556;5110.948890511085;5122.667026643257;5130.4613015633195;4891.1195984722735;4953.257011448293;4955.405351357824;5005.824796132154;5031.622628302892;4968.304437378733;4972.055309491221;4974.60203183748;4984.526469985346;5044.066847633163;4987.600991920674;5004.549590536869;5007.824726134568;5028.748562571894;5031.396232452129;5309.681419114827;5406.837794866121;5451.155070964007;5532.889342213173;5533.778648854041;6031.665749321902;6048.184499972633;6050.939490605082;6052.668273540387;6111.327753947106;6059.731783994567;6073.459656790947;6081.553553233586;6082.139827336667;6105.694715264219;5407.134858422673;5436.184572314145;5482.150266708666;5496.477834605706;5511.063119269734;6037.893397483076;6041.795780758128;6041.846483526376;6081.543884208613;6091.299500557404;5646.2942132233475;5833.445822646927;5842;5846.064629659234;5850.5612079094235;5741.397153298927;5775.595708300379;5813.912791308134;5825.76696932118;5827.796027139115;5756.251687280626;5783.306003279633;5805.883882322414;5806.274215723035;5808.796692115756;5636.774529018793;5653.321601407775;5811.3026436827;5815.9709201453725;5838.9124163137585;4395.472543294825;4401.735895846259;4403.669724770655;4428.3800267962515;4446.221911165598;3929.8035098244973;3938.1532970410926;3946.7631942083567;3953.6244056814558;3971.6624086952356;5428.4842939920645;5463.235147079412;5478.178273258964;5510.173473978935;5524.751386187631;5818.156367326798;5841.182234487175;5841.970790146107;5869.765209391577;5914.408559144051;5435.184722291688;5444.047291723932;5446.836594902159;5451.427600102012;5485.725713714378;4968.925466118011;5032.018756342478;5057.291979122926;5059.87350316245;5105.234214867725;6101.156499726972;6111.227117700271;6113.111460343413;6113.202667687823;6144.324124346318;5953.91069133972;5957.046872500379;5958.731857066529;5959.0763431668165;5959.433853783884;5907.556933230111;5979.22270104901;5992.580519363602;6011.458968692838;6102.4507794298725;5764.42355764437;5806;5807.041838096667;5813.6221145625395;5813.76744930198;5885.764569417175;5914.319853216935;5940.405959404025;5943.7028148591535;5946.108083787466;5606.074997625509;5633.464820842013;5637.943620563742;5706.572007099568;5740.425957404226;5735.569832262514;5736.799212027559;5741.741621626953;5743.655380677173;5759.193712880116;5458.263134476953;5623.156526521055;5627.521660658726;5634.85912852182;5639.7744090237575;5756.366799651951;5804.071348584206;5825.213596164633;5907.556933229939;5910.763569457174;5748.252727145445;5749.252597162342;5756.856078598069;5758.107493338539;5803.245578074823 06:00:13 INFO - PROCESS | 3362 | |1;ext.html;620.9844753881154;624.0514418084515;629.6473974574236;638.9265234498031;644.2719726708822;31477;43635.34546981794;44945;45020.77489612551;48268.75865620676;45611.31583026249;46137;46169.538304616945;46220.53779462205;46224.3066354005;8657.177568131017;8874.86687699685;8874.955625221864;8875.245604123656;8882.644694212224;8746.737597872074;8882.156195161482;8882.511461869595;8886.333524985619;8886.511241881693;8888.644454221823;8947.77630559238;8955.596998135066;8956.596953137092;8962.820743585124;8817.382783205177;8853.911460885438;8872.201501864798;8875.156860098281;8875.245604123656;8690.826183476294;8794.69218577353;8795.604197811113;8797.29621630268;8804.163604457566;41395.1720965582;41784.79107604473;41885.1622967542;42044;42069.789651051855;3466.5248783784464;4003.3594624860175;4175.603317684815;4274.957250427487;4345.891352716176;32425;32553.83723081393;33016.33967320664;33808.6619133808;34017.48973765395;4060.817263223162;4078.3882417637296;4082.3672330788777;4133.338665813486;4161.771102589357;358442;362412;362519.9999999974;362590;363847;51284.74357628263;51814.740926295126;53214.20178697323;59372.32824522821;59974.40025599775;64082.67958660177;64097.679511602146;64240;64251.03623445652;64307;15978.360865565479;16159.43441979525;16174.353025878832;16176;16210.35158593643;11700.414979251003;12483.56307529232;12570.497180112876;12672.49310027607;12703.491860325668;18161.273549058154;18245.543861403305;18259.360922367654;18301.54246143857;18369.7244541332;6131.816045518642;6238.875222495525;6268.310485846553;6372.904406433907;6388.201474815648;966.1739212972948;1078.449990504848;1084.4902895639036;1101.1686176936362;1177.181858608259;33438.66561334355;33490.66509334924;33523.83238083843;33650;33762.66237337644;1131.3438205840594;1135.2053562506278;1154.7228665120479;1183.3018519073787;1202.6512311429587;17378.304867805145;17534.298628054734;17567.73648395275;17681.292748290183;18360.806317954517;490670;494969;495230;496087;503273;58922;59718.40281597216;59785.10322345168;59958;59973.700131499936;1282.7049778550986;1300.0704496285011;1303.9869601303865;1390.7496650602786;1442.5528086293282;25879.61180582255;33774;34316.82841585776;36112.27775444529;36588;57848.42151578599;58419.70790146022;58567.4143258579;58605.120923185335;58618.706906465195;469841;482424;483797;770324;795767;25777.355566110997;26098.60852087258;44408.77795611001;46209.306860397795;47504.049919002115;48484.757576213306;50241;50532.747336263084;50980.37263122297;51804;42390.57609423866;42589;43545.78227108844;44464.77767611271;44849.77575112104;42490;42522.149557008066;42703.5729642712;43086.56913430826;43376.56623433851;43081;43962.56037439585;44292.55707443013;44319.77840110779;44328.778356108014;36924.44613330749;37966.43050354302;38635.61364386432;39234;39569;29233.26916827011;29425;29678;29682.211968665903;30123.69876301209 06:00:13 INFO - PROCESS | 3362 | |2;jquery.html;385.2064746621957;396.69652715672504;397.3840547151914;403.43317638717605;419.09266438161364;14855.55433336999;17997.190126444308;18455.44633660989;19617.411477655656;19638.214471421143;15241.771373429407;17769.466915992507;18233.54416139597;18381;18400.631987360244;5510.476504732054;5672.943270567303;5684.346300175471;5722.399148089453;5728.283964504437;4077.368007958771;5542.5565954723725;5640.323161220659;5918;6228.688565571726;6163.229596300463;6199.938000619981;6202.255729312466;6224.284207316148;6238.781642642509;6016.067509536029;6257.499400047986;6312.116303717483;6314.7474101035905;6314.810555683314;5260.8684782880355;5549.084401073818;5561.304836895388;5566.55467562594;5570.387257401682;22409.775902240934;22854.08583656652;22951.88524057369;22994.425139371484;23007.654885176737;2299.0918587158144;2394.4253379188867;2525.2802951158833;2546.070684200272;2550.8979640814346;13763.655908602364;14194.787078193733;14195.716085678228;14321.212333321662;14668.193249371281;1947.552063025512;1976.723258743777;1991.1438081624894;2026.5642886779412;2037.2869495676543;71104;74391.62804185999;75258.24741752566;78359.21640783576;78765;10151.137153342048;10246.231532635082;10778.94610526958;10932.56269749201;11179.608713695145;15350.155741434104;15372;15399.07605543671;15428.922855385652;15443.613909652124;7704.730334438268;8073;8073.192680731997;8167.550784706779;8186.713465028695;6802.802682739105;7581.696732130653;7675.731349402744;7773.961130194313;7800.375969922393;4328.870133895988;4626.537346265347;4629.6990695605355;4703.623710103184;4755.429348478136;1934.6264152451918;1974.4076776966851;1980.4157773456866;1991.71120187572;1999.6800511918022;880.9163129502687;968.5931908598405;984.886738025122;995.2088089968493;1033.2973577967055;18391.172397242157;18574.25702971866;18734.437966861016;18984.14571344293;19073.237070517025;1016.6035246253966;1029.161233594618;1055.762453447968;1071.3678929431674;1082.6751974407803;8689.522076285864;10484.108850747773;10711.625093121858;10763.78472430547;10774.461276936121;497326;501336;505510;511948;512505;95986;100256.49871750595;100264.49867750761;100301.49849250707;100713.49643251736;1039.77644806367;1073.179018051176;1086.2124959404528;1096.780643871229;1099.0218705352243;17326.88282178372;17455;17461.738073929155;17658.646827063643;17805.821941780418;34502.29012971562;38372.42441363438;39932.600673992885;43331.78334108309;43920.56079439165;56565.151522726366;57074.714626426605;59111.704441477516;59352;59389;8374.413791034813;8515.48907065578;8732.172022299746;8890.777730556787;8955.462672239686;12888.677783055498;13152.80270795958;13222.471101155847;13630.250336231602;13815.032947693566;11450.198486105892;11662.94168529152;11777.941110294394;11966.58116965902;11984.161108722654;11454.599089031844;11460;11629.941850290694;11680.299182049104;11754.353510557;11693.356865372487;11715.414229288672;11911.3448760319;11968.341741204318;11989.700257493632;8502.957485212535;8606.870896936676;8645.827083458422;8709.564521774013;8798.296136308953;8924.018357980747;11352.375619340684;11676;11696.239744416585;11805.409729513662 06:00:13 INFO - PROCESS | 3362 | |3;mootools.html;1321.2138777427426;1514.8939574229805;1539.1303913288991;1683.3182561062774;1824.31588154442;8481.575921203937;8604.354673399497;8614.440061396013;8989.235914947221;8998.370114092017;8705.73882783516;8934.15125563072;8941.552922353889;8941.821163576724;8974.237189838856;2065.638513260181;2094.8219401350902;2095.8008989146006;2374.6675465434855;2408.036785285882;2342.0046480245915;2378.7502312257225;2392.7487613800563;2421.8425802322795;2426.114468219096;2364.8226383021256;2370.5614461324626;2385.189035727852;2393.5930891748444;2439.8048156147465;2053.938381848547;2337.1586228957563;2395.4969456414174;2426.38127277544;2426.6602675625427;2361.9409514762096;2420.685310909588;2429.7327293997646;2430.793382562484;2432.647266146399;9030.142136497023;9093.40892841963;9095.7271281861;9097.90902090984;9106.86339704905;5297.894042119136;5438.864028399322;5443.836684899459;5449.509544141007;5452.754626041838;3316.502524621302;3332.800031998088;3504.5093686883856;3506.281212351462;3555.8933232002823;1213.1568559850907;1219.8658147603755;2050.9794902051085;2106.2101711858054;2109.135254545629;12035.518579256819;12117.818232726517;12128.211666241667;12135.93932030343;12142.878571214264;4454.599086082203;4528.88677783058;4614.146382919171;4625.6530760192445;4629.0973260214605;9377.1091746284;9382.5308734563;9386.90613093874;9390.812183756287;9403.106704863027;5233.659812112201;5235.05768961583;5243.921341179809;5252.816151434758;5261.053010458078;4466.620337271368;4833.73414462208;4902.48523904992;4970.826021089245;4972.353594032825;3824.7513911595656;3832;3892.338302488584;3902.9609703902597;3927.5483319418063;1147.7417581044365;1148.4602236948622;1174.1780753472603;1175.7707247086737;1185.5080141741253;997.4065431068502;1014.8274793285159;1015.9644412445529;1021.0759262867117;1027.912627426677;6017.969910150508;6046.18376519173;6056.606320589148;6231.2522497300615;6297.4017468340435;454.6998980672806;461.17834553513086;467.2873867352315;471.4531143873091;473.6305681568382;4272.081502476983;4296.076343586144;4325.940144664577;4333.71830830995;4345.500267469219;11123;11496.252743571642;11584.304941703525;11593.594224202112;11601.303921764722;10711.089557387553;11077.612283570037;11501.654950351503;11501.712457188638;11504.53981840717;8386.454880432751;8501.489910605384;8509.319254459504;8557.572121393905;8589.355798315151;6223.844403889939;6415.262244841903;6467.676616169267;6468.5472016958365;6616.172978377703;10212.795744084928;10480.109190718875;10715.24993250465;10722.249442538947;10725.80121075162;10783.892161078289;10877.021068103908;10894.400807955639;10902.836457452986;10905;7403.407727381689;7784.844303113793;7884.21157884207;7958.323542498721;8002.03975522941;8997.100289971213;8997.2455371202;9105;9113.817723645623;9119.726408207764;7752.573608451589;7992.440529163136;8009.91990080115;8012.399070069651;8109.067457242257;7773.37812974972;7855.84288314242;7908.683652653829;7969.551186870178;8019.799505012421;7357.632118393952;7366.263373662591;7435.293647103733;7448.478606497493;7464.440166987606;5271;5402.918956215582;5423.996560636295;5457.508824205841;5509.338879334506;5309.389420216725;5418;5455.0726376515295;5478.616496845182;5537.5569954404355 06:00:13 INFO - PROCESS | 3362 | |4;prototype.html;321.4070040774771;330.3953764610764;332.78202777180945;333.7030043261497;338.9983050084749;5253.89492210156;5291.788328466857;5295.841124766253;5298.735063246837;5303.23103150043;5275.525202731754;5286.286351342567;5286.947130528693;5294.100002999489;5296.311479507668;4011.699122565805;4112.115895082557;4126.958730412703;4165.666986564301;4184.560621134783;4062.573429789874;4116.197341518405;4140.8964775880695;4142.130152667944;4174.726708353951;4055.9797201013953;4059.776712280823;4087.81604827782;4088.9591104089022;4107.8973025674295;3869.671077958377;3938.3895496198134;4031.8387264509383;4058.7564746115327;4120.649744771698;3584.372734771405;3588.4796704477967;3589.6948759355487;3590.694790942773;3600.71194304455;4994.500549945013;4997.525235102659;4999.700137936554;5000.349954505891;5048.1670524363435;4447.62195213404;4532.410786597754;4631.258998560248;4682.438107427097;4717.410323709536;5359.464053594609;5406.405295417501;5423.376311724162;5429.891402171974;5457.972710136424;3960.5643379228263;3963.346047902093;3969.0474286171398;3986.123052928351;3990.74060186087;5422.91865622016;5605.73870879053;5614.035087719307;5666.121751128581;5684;4036.455078564415;4060.0864805418546;4069.2268468990796;4074.5721699221153;4093.85671501496;4139.19285739278;4151.543330233671;4151.813168407429;4156.688248381323;4165.687573432005;4487;4682.765861706901;4688.97655511727;4701.623870090384;4752.40794333902;5416.810411635653;5470.480304371078;5490.752916118784;5510.437646494399;5531.45119366578;1388.1462900316233;1411.5200831717266;1413.3286688822727;1413.5829930170419;1415.6248594122567;899.6671231644202;915.9221466175317;928.9827638735709;956.0917128727737;958.6357184269933;5196.792128314825;5205.3863302376385;5212.947870521246;5229.398619158769;5236.607254455855;5652.349979752299;5659.915101273484;5661.915071273934;5668.781212039431;5681.931756851254;5212.947870521322;5300.867478313073;5311.3891902431715;5353.491418315254;5409.404965453797;2967.4658561459146;2979.7914146010003;3015.7888947773445;3021.3957208558377;3041.9087427377212;5659.660420374791;5711.8000869969355;5875.324337701134;5886;5888.646681199141;5778.093229234342;5794.913076303858;5799.014167591519;5815.76736930518;5818.389069147678;5708.971455142698;5746.5233533712335;5749.540036797046;5759;5806.2451881255165;5338.8932221356135;5600.635958662837;5617.971910140586;5653.971730141323;5697.601167918206;5563.859408821263;5581.795190899491;5590.273264475592;5604.523615492566;5623.606347555796;5734.541236701138;5785.739641716049;5787.334456537552;5798.5651076168615;5820.185174075548;3921.92156156881;4152.501699796044;4155.690957348425;4166.145940082337;4174.123434078756;5614.606977511535;5629;5639.718014099197;5639.7744090237575;5664.688442135722;5301.310829592283;5468;5490.3528941318245;5499.230107784833;5502.862428439321;5471.6169868108855;5488.4237155098135;5496.258005169251;5500.80747173847;5506.669599824023;5200.97399513;5261.3686357637325;5407.459254074561;5427.294451721409;5430.348358197041;5567.1350097716095;5577.860553486195;5586.832395027993;5588.497035266845;5611;5421.891562168814;5422.671445495879;5440.183972404171;5454.9271276914515;5480.862978425571 06:00:13 INFO - PROCESS | 3362 | |5;yui.html;702.8453740177163;714.392766148774;750.2160242546538;789.1950210785;802.5946896817106;13928.860711392883;15343.079415235079;15352.539423817276;15371.84628153718;15395.615109622237;14299.356528956196;14352.784708229385;14410.423583056692;14440;14496.710065798678;679.8028571714196;796.6693822063866;816.7345612675874;817.8241678039235;830.0703212402118;824.1058451580013;826.5040975414763;829.0093338460542;829.4442723375353;829.8921140251758;872.7948932000975;874.6763697431927;874.9981271444193;875.089906497242;875.5753459572103;700.9824754381156;712.2414628420742;834;854.5086575219211;865.4071960706905;622.3465361370543;625.2247213455328;625.5089754542707;625.809128215894;625.9906101408483;14622.415103395851;14637.6340591485;14674.853251467455;14692.338844752012;14697.706045879022;14013.78979315301;14343.56969290923;14355.71288574233;14440.927795361062;14559.70880582393;11456.4844581994;11486.885131148749;11663.066954643607;11734;11737.413129343498;3851.768893866377;4395.824167033315;4399.23013472641;4447.799849006802;4618.030213655136;72648;73140;73186;73197;73740.63129684371;10298.330608510572;10516.26386152962;10683.519241634145;10854.891451085388;10896.147654898687;17895.10524473797;17983.73024404635;18001.09994500296;18057.638847223243;18157.818421815613;8469.957650211833;8523.48859068458;8535.658573656985;8546.529940853312;8565.229129378262;4769.523047695203;4837.591602297471;4895.828645997373;4904.43598986114;4914;3370.3090866372336;3456.8962931112105;3458.844352004166;3460.2214501736908;3469.809160496197;550.6052248712849;622.7477871462065;638.5211091681239;646.3891622416771;664.2626684380334;604.8729766748944;705.946780175742;709.3155105323284;755.5013690963938;804.4770898915751;10587.84118238227;10877.044064411435;10946.56213751457;11031.724206894893;11106.944465277784;687.669918439152;705.1855107351017;718.6011763471323;749.868772964729;785.7564155111819;4751.738654373973;5058.519440653132;5133.12736834739;5229.869253268699;5249.42256351801;92851;95919.52040239754;95952;109571.45214273878;114103;93102.53448732712;95358;97092.51453742827;98390;98440.50779746055;54311;86220.56889715636;87981;89356.10643893608;90942;9945.602175912882;9975.401475911469;9980.301378903407;10057;10084.647037353658;50864.745676271385;51348.22977655413;51778.223326650885;52173.478265216865;52296.21555676592;68705.65647171732;68721.65639171773;74782;75820;77120;12525.686857828627;12931.418086185957;12969.546065888026;13169.934150329187;13354.93322533381;14671.70656586841;14899.404023838924;14970.925145374204;15208.46770363032;15406;14145.787813182606;14241.50154744579;14487.130772153705;14603.415863365772;14643.56069317922;13766.793498097337;14094.78857817113;14186.574402767934;14275.571732848031;14590.708185836436;12846.486140554272;13963.930180349033;14040.929795350958;14047.36786844574;14078;10678.199135064746;10753.062707124414;11074.889251107386;11205.887941120485;11341.149413794163;10596.223422708965;11189.888101118884;11281.153913456359;11320.716982075513;11341.546338146713 06:00:13 INFO - PROCESS | 3362 | __end_tp_report 06:00:13 INFO - PROCESS | 3362 | __start_cc_report 06:00:13 INFO - PROCESS | 3362 | _x_x_mozilla_cycle_collect,963 06:00:13 INFO - PROCESS | 3362 | __end_cc_report 06:00:13 INFO - PROCESS | 3362 | __startTimestamp1465304413373__endTimestamp 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | ------- Summary: start ------- 06:00:13 INFO - PROCESS | 3362 | Number of tests: 6 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | [#0] dojo.html Cycles:165 Average:5459.04 Median:5637.94 stddev:632.10 (11.2%) stddev-sans-first:608.16 06:00:13 INFO - PROCESS | 3362 | Values: 3176.9 3177.0 3177.7 3214.9 3233.1 5297.4 5335.4 5473.4 5544.7 5578.9 5499.1 5520.1 5528.9 5569.4 5615.2 4933.1 4987.7 5027.8 5033.9 5174.9 5044.6 5076.6 5110.9 5122.7 5130.5 4891.1 4953.3 4955.4 5005.8 5031.6 4968.3 4972.1 4974.6 4984.5 5044.1 4987.6 5004.5 5007.8 5028.7 5031.4 5309.7 5406.8 5451.2 5532.9 5533.8 6031.7 6048.2 6050.9 6052.7 6111.3 6059.7 6073.5 6081.6 6082.1 6105.7 5407.1 5436.2 5482.2 5496.5 5511.1 6037.9 6041.8 6041.8 6081.5 6091.3 5646.3 5833.4 5842.0 5846.1 5850.6 5741.4 5775.6 5813.9 5825.8 5827.8 5756.3 5783.3 5805.9 5806.3 5808.8 5636.8 5653.3 5811.3 5816.0 5838.9 4395.5 4401.7 4403.7 4428.4 4446.2 3929.8 3938.2 3946.8 3953.6 3971.7 5428.5 5463.2 5478.2 5510.2 5524.8 5818.2 5841.2 5842.0 5869.8 5914.4 5435.2 5444.0 5446.8 5451.4 5485.7 4968.9 5032.0 5057.3 5059.9 5105.2 6101.2 6111.2 6113.1 6113.2 6144.3 5953.9 5957.0 5958.7 5959.1 5959.4 5907.6 5979.2 5992.6 6011.5 6102.5 5764.4 5806.0 5807.0 5813.6 5813.8 5885.8 5914.3 5940.4 5943.7 5946.1 5606.1 5633.5 5637.9 5706.6 5740.4 5735.6 5736.8 5741.7 5743.7 5759.2 5458.3 5623.2 5627.5 5634.9 5639.8 5756.4 5804.1 5825.2 5907.6 5910.8 5748.3 5749.3 5756.9 5758.1 5803.2 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | [#1] ext.html Cycles:180 Average:65023.96 Median:43590.56 stddev:134184.54 (307.8%) stddev-sans-first:134473.83 06:00:13 INFO - PROCESS | 3362 | Values: 621.0 624.1 629.6 638.9 644.3 31477.0 43635.3 44945.0 45020.8 48268.8 45611.3 46137.0 46169.5 46220.5 46224.3 8657.2 8874.9 8875.0 8875.2 8882.6 8746.7 8882.2 8882.5 8886.3 8886.5 8888.6 8947.8 8955.6 8956.6 8962.8 8817.4 8853.9 8872.2 8875.2 8875.2 8690.8 8794.7 8795.6 8797.3 8804.2 41395.2 41784.8 41885.2 42044.0 42069.8 3466.5 4003.4 4175.6 4275.0 4345.9 32425.0 32553.8 33016.3 33808.7 34017.5 4060.8 4078.4 4082.4 4133.3 4161.8 358442.0 362412.0 362520.0 362590.0 363847.0 51284.7 51814.7 53214.2 59372.3 59974.4 64082.7 64097.7 64240.0 64251.0 64307.0 15978.4 16159.4 16174.4 16176.0 16210.4 11700.4 12483.6 12570.5 12672.5 12703.5 18161.3 18245.5 18259.4 18301.5 18369.7 6131.8 6238.9 6268.3 6372.9 6388.2 966.2 1078.4 1084.5 1101.2 1177.2 33438.7 33490.7 33523.8 33650.0 33762.7 1131.3 1135.2 1154.7 1183.3 1202.7 17378.3 17534.3 17567.7 17681.3 18360.8 490670.0 494969.0 495230.0 496087.0 503273.0 58922.0 59718.4 59785.1 59958.0 59973.7 1282.7 1300.1 1304.0 1390.7 1442.6 25879.6 33774.0 34316.8 36112.3 36588.0 57848.4 58419.7 58567.4 58605.1 58618.7 469841.0 482424.0 483797.0 770324.0 795767.0 25777.4 26098.6 44408.8 46209.3 47504.0 48484.8 50241.0 50532.7 50980.4 51804.0 42390.6 42589.0 43545.8 44464.8 44849.8 42490.0 42522.1 42703.6 43086.6 43376.6 43081.0 43962.6 44292.6 44319.8 44328.8 36924.4 37966.4 38635.6 39234.0 39569.0 29233.3 29425.0 29678.0 29682.2 30123.7 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | [#2] jquery.html Cycles:180 Average:29465.26 Median:12625.49 stddev:83374.18 (660.4%) stddev-sans-first:83579.47 06:00:13 INFO - PROCESS | 3362 | Values: 385.2 396.7 397.4 403.4 419.1 14855.6 17997.2 18455.4 19617.4 19638.2 15241.8 17769.5 18233.5 18381.0 18400.6 5510.5 5672.9 5684.3 5722.4 5728.3 4077.4 5542.6 5640.3 5918.0 6228.7 6163.2 6199.9 6202.3 6224.3 6238.8 6016.1 6257.5 6312.1 6314.7 6314.8 5260.9 5549.1 5561.3 5566.6 5570.4 22409.8 22854.1 22951.9 22994.4 23007.7 2299.1 2394.4 2525.3 2546.1 2550.9 13763.7 14194.8 14195.7 14321.2 14668.2 1947.6 1976.7 1991.1 2026.6 2037.3 71104.0 74391.6 75258.2 78359.2 78765.0 10151.1 10246.2 10778.9 10932.6 11179.6 15350.2 15372.0 15399.1 15428.9 15443.6 7704.7 8073.0 8073.2 8167.6 8186.7 6802.8 7581.7 7675.7 7774.0 7800.4 4328.9 4626.5 4629.7 4703.6 4755.4 1934.6 1974.4 1980.4 1991.7 1999.7 880.9 968.6 984.9 995.2 1033.3 18391.2 18574.3 18734.4 18984.1 19073.2 1016.6 1029.2 1055.8 1071.4 1082.7 8689.5 10484.1 10711.6 10763.8 10774.5 497326.0 501336.0 505510.0 511948.0 512505.0 95986.0 100256.5 100264.5 100301.5 100713.5 1039.8 1073.2 1086.2 1096.8 1099.0 17326.9 17455.0 17461.7 17658.6 17805.8 34502.3 38372.4 39932.6 43331.8 43920.6 56565.2 57074.7 59111.7 59352.0 59389.0 8374.4 8515.5 8732.2 8890.8 8955.5 12888.7 13152.8 13222.5 13630.3 13815.0 11450.2 11662.9 11777.9 11966.6 11984.2 11454.6 11460.0 11629.9 11680.3 11754.4 11693.4 11715.4 11911.3 11968.3 11989.7 8503.0 8606.9 8645.8 8709.6 8798.3 8924.0 11352.4 11676.0 11696.2 11805.4 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | [#3] mootools.html Cycles:180 Average:5941.56 Median:4627.38 stddev:3375.95 (73.0%) stddev-sans-first:3367.56 06:00:13 INFO - PROCESS | 3362 | Values: 1321.2 1514.9 1539.1 1683.3 1824.3 8481.6 8604.4 8614.4 8989.2 8998.4 8705.7 8934.2 8941.6 8941.8 8974.2 2065.6 2094.8 2095.8 2374.7 2408.0 2342.0 2378.8 2392.7 2421.8 2426.1 2364.8 2370.6 2385.2 2393.6 2439.8 2053.9 2337.2 2395.5 2426.4 2426.7 2361.9 2420.7 2429.7 2430.8 2432.6 9030.1 9093.4 9095.7 9097.9 9106.9 5297.9 5438.9 5443.8 5449.5 5452.8 3316.5 3332.8 3504.5 3506.3 3555.9 1213.2 1219.9 2051.0 2106.2 2109.1 12035.5 12117.8 12128.2 12135.9 12142.9 4454.6 4528.9 4614.1 4625.7 4629.1 9377.1 9382.5 9386.9 9390.8 9403.1 5233.7 5235.1 5243.9 5252.8 5261.1 4466.6 4833.7 4902.5 4970.8 4972.4 3824.8 3832.0 3892.3 3903.0 3927.5 1147.7 1148.5 1174.2 1175.8 1185.5 997.4 1014.8 1016.0 1021.1 1027.9 6018.0 6046.2 6056.6 6231.3 6297.4 454.7 461.2 467.3 471.5 473.6 4272.1 4296.1 4325.9 4333.7 4345.5 11123.0 11496.3 11584.3 11593.6 11601.3 10711.1 11077.6 11501.7 11501.7 11504.5 8386.5 8501.5 8509.3 8557.6 8589.4 6223.8 6415.3 6467.7 6468.5 6616.2 10212.8 10480.1 10715.2 10722.2 10725.8 10783.9 10877.0 10894.4 10902.8 10905.0 7403.4 7784.8 7884.2 7958.3 8002.0 8997.1 8997.2 9105.0 9113.8 9119.7 7752.6 7992.4 8009.9 8012.4 8109.1 7773.4 7855.8 7908.7 7969.6 8019.8 7357.6 7366.3 7435.3 7448.5 7464.4 5271.0 5402.9 5424.0 5457.5 5509.3 5309.4 5418.0 5455.1 5478.6 5537.6 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | [#4] prototype.html Cycles:180 Average:4631.42 Median:5297.52 stddev:1354.63 (25.6%) stddev-sans-first:1319.23 06:00:13 INFO - PROCESS | 3362 | Values: 321.4 330.4 332.8 333.7 339.0 5253.9 5291.8 5295.8 5298.7 5303.2 5275.5 5286.3 5286.9 5294.1 5296.3 4011.7 4112.1 4127.0 4165.7 4184.6 4062.6 4116.2 4140.9 4142.1 4174.7 4056.0 4059.8 4087.8 4089.0 4107.9 3869.7 3938.4 4031.8 4058.8 4120.6 3584.4 3588.5 3589.7 3590.7 3600.7 4994.5 4997.5 4999.7 5000.3 5048.2 4447.6 4532.4 4631.3 4682.4 4717.4 5359.5 5406.4 5423.4 5429.9 5458.0 3960.6 3963.3 3969.0 3986.1 3990.7 5422.9 5605.7 5614.0 5666.1 5684.0 4036.5 4060.1 4069.2 4074.6 4093.9 4139.2 4151.5 4151.8 4156.7 4165.7 4487.0 4682.8 4689.0 4701.6 4752.4 5416.8 5470.5 5490.8 5510.4 5531.5 1388.1 1411.5 1413.3 1413.6 1415.6 899.7 915.9 929.0 956.1 958.6 5196.8 5205.4 5212.9 5229.4 5236.6 5652.3 5659.9 5661.9 5668.8 5681.9 5212.9 5300.9 5311.4 5353.5 5409.4 2967.5 2979.8 3015.8 3021.4 3041.9 5659.7 5711.8 5875.3 5886.0 5888.6 5778.1 5794.9 5799.0 5815.8 5818.4 5709.0 5746.5 5749.5 5759.0 5806.2 5338.9 5600.6 5618.0 5654.0 5697.6 5563.9 5581.8 5590.3 5604.5 5623.6 5734.5 5785.7 5787.3 5798.6 5820.2 3921.9 4152.5 4155.7 4166.1 4174.1 5614.6 5629.0 5639.7 5639.8 5664.7 5301.3 5468.0 5490.4 5499.2 5502.9 5471.6 5488.4 5496.3 5500.8 5506.7 5201.0 5261.4 5407.5 5427.3 5430.3 5567.1 5577.9 5586.8 5588.5 5611.0 5421.9 5422.7 5440.2 5454.9 5480.9 06:00:13 INFO - PROCESS | 3362 | 06:00:13 INFO - PROCESS | 3362 | [#5] yui.html Cycles:180 Average:20085.72 Median:4803.56 stddev:28213.06 (587.3%) stddev-sans-first:28254.66 06:00:13 INFO - PROCESS | 3362 | Values: 702.8 714.4 750.2 789.2 802.6 13928.9 15343.1 15352.5 15371.8 15395.6 14299.4 14352.8 14410.4 14440.0 14496.7 679.8 796.7 816.7 817.8 830.1 824.1 826.5 829.0 829.4 829.9 872.8 874.7 875.0 875.1 875.6 701.0 712.2 834.0 854.5 865.4 622.3 625.2 625.5 625.8 626.0 14622.4 14637.6 14674.9 14692.3 14697.7 14013.8 14343.6 14355.7 14440.9 14559.7 11456.5 11486.9 11663.1 11734.0 11737.4 3851.8 4395.8 4399.2 4447.8 4618.0 72648.0 73140.0 73186.0 73197.0 73740.6 10298.3 10516.3 10683.5 10854.9 10896.1 17895.1 17983.7 18001.1 18057.6 18157.8 8470.0 8523.5 8535.7 8546.5 8565.2 4769.5 4837.6 4895.8 4904.4 4914.0 3370.3 3456.9 3458.8 3460.2 3469.8 550.6 622.7 638.5 646.4 664.3 604.9 705.9 709.3 755.5 804.5 10587.8 10877.0 10946.6 11031.7 11106.9 687.7 705.2 718.6 749.9 785.8 4751.7 5058.5 5133.1 5229.9 5249.4 92851.0 95919.5 95952.0 109571.5 114103.0 93102.5 95358.0 97092.5 98390.0 98440.5 54311.0 86220.6 87981.0 89356.1 90942.0 9945.6 9975.4 9980.3 10057.0 10084.6 50864.7 51348.2 51778.2 52173.5 52296.2 68705.7 68721.7 74782.0 75820.0 77120.0 12525.7 12931.4 12969.5 13169.9 13354.9 14671.7 14899.4 14970.9 15208.5 15406.0 14145.8 14241.5 14487.1 14603.4 14643.6 13766.8 14094.8 14186.6 14275.6 14590.7 12846.5 13963.9 14040.9 14047.4 14078.0 10678.2 10753.1 11074.9 11205.9 11341.1 10596.2 11189.9 11281.2 11320.7 11341.5 06:00:13 INFO - PROCESS | 3362 | -------- Summary: end -------- 06:00:13 INFO - PROCESS | 3362 | 06:00:14 INFO - TEST-INFO | 3362: exit 0 06:00:14 INFO - TEST-OK | dromaeo_css | took 1116420ms 06:00:14 INFO - TEST-START | kraken 06:00:14 INFO - operating with platform_type : linux_ 06:00:14 INFO - Initialising browser for kraken test... 06:00:14 INFO - TEST-INFO | started process 3537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwFnP7t/profile http://localhost:38411/getInfo.html) 06:00:18 INFO - PROCESS | 3537 | __metrics Screen width/height:1600/1200 06:00:18 INFO - PROCESS | 3537 | colorDepth:24 06:00:18 INFO - PROCESS | 3537 | Browser inner width/height: 1024/697 06:00:18 INFO - PROCESS | 3537 | __metrics 06:00:19 ERROR - PROCESS | 3537 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:00:19 INFO - PROCESS | 3537 | console.error: PushService: 06:00:19 INFO - PROCESS | 3537 | stateChangeProcessEnqueue: Error transitioning state 06:00:19 INFO - PROCESS | 3537 | UnknownError 06:00:20 INFO - TEST-INFO | 3537: exit 0 06:00:20 INFO - Browser initialized. 06:00:20 INFO - Running cycle 1/1 for kraken test... 06:00:20 INFO - TEST-INFO | started process 3620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwFnP7t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:31 INFO - PROCESS | 3620 | RSS: Main: 156262400 06:00:31 INFO - PROCESS | 3620 | 06:00:34 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38411/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:35 INFO - PROCESS | 3620 | RSS: Main: 214835200 06:00:35 INFO - PROCESS | 3620 | 06:00:38 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38411/tests/kraken/driver.html?testName=audio-dft) 06:00:38 INFO - PROCESS | 3620 | RSS: Main: 201482240 06:00:38 INFO - PROCESS | 3620 | 06:00:41 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38411/tests/kraken/driver.html?testName=audio-fft) 06:00:42 INFO - PROCESS | 3620 | RSS: Main: 268898304 06:00:42 INFO - PROCESS | 3620 | 06:00:44 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38411/tests/kraken/driver.html?testName=audio-oscillator) 06:00:45 INFO - PROCESS | 3620 | RSS: Main: 179748864 06:00:45 INFO - PROCESS | 3620 | 06:00:47 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38411/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:47 INFO - PROCESS | 3620 | RSS: Main: 183484416 06:00:47 INFO - PROCESS | 3620 | 06:00:50 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38411/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:51 INFO - PROCESS | 3620 | RSS: Main: 218247168 06:00:51 INFO - PROCESS | 3620 | 06:00:54 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38411/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:55 INFO - PROCESS | 3620 | RSS: Main: 220389376 06:00:55 INFO - PROCESS | 3620 | 06:00:58 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38411/tests/kraken/driver.html?testName=json-parse-financial) 06:00:58 INFO - PROCESS | 3620 | RSS: Main: 220516352 06:00:58 INFO - PROCESS | 3620 | 06:01:00 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38411/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:00 INFO - PROCESS | 3620 | RSS: Main: 207859712 06:01:00 INFO - PROCESS | 3620 | 06:01:02 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:03 INFO - PROCESS | 3620 | RSS: Main: 210833408 06:01:03 INFO - PROCESS | 3620 | 06:01:05 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:06 INFO - PROCESS | 3620 | RSS: Main: 216453120 06:01:06 INFO - PROCESS | 3620 | 06:01:09 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:09 INFO - PROCESS | 3620 | RSS: Main: 225222656 06:01:09 INFO - PROCESS | 3620 | 06:01:12 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:13 INFO - PROCESS | 3620 | RSS: Main: 225988608 06:01:13 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | Cycle 1(1): loaded http://localhost:38411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38411/tests/kraken/driver.html?testName=ai-astar) 06:01:14 INFO - PROCESS | 3620 | RSS: Main: 268947456 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | __start_tp_report 06:01:14 INFO - PROCESS | 3620 | _x_x_mozilla_page_load 06:01:14 INFO - PROCESS | 3620 | _x_x_mozilla_page_load_details 06:01:14 INFO - PROCESS | 3620 | |i|pagename|runs| 06:01:14 INFO - PROCESS | 3620 | |0;ai-astar;110;105;109;110;110;111;109;110;109;109 06:01:14 INFO - PROCESS | 3620 | |1;audio-beat-detection;154;125;139;153;125;149;154;129;183;131 06:01:14 INFO - PROCESS | 3620 | |2;audio-dft;160;160;160;159;160;163;160;161;160;161 06:01:14 INFO - PROCESS | 3620 | |3;audio-fft;73;74;75;129;75;77;75;75;98;75 06:01:14 INFO - PROCESS | 3620 | |4;audio-oscillator;84;86;122;84;84;85;129;85;84;137 06:01:14 INFO - PROCESS | 3620 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;116;116 06:01:14 INFO - PROCESS | 3620 | |6;imaging-darkroom;147;145;145;146;146;145;146;146;148;146 06:01:14 INFO - PROCESS | 3620 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;94 06:01:14 INFO - PROCESS | 3620 | |8;json-parse-financial;54;52;52;54;54;54;53;53;52;53 06:01:14 INFO - PROCESS | 3620 | |9;json-stringify-tinderbox;63;64;63;62;63;62;67;63;66;61 06:01:14 INFO - PROCESS | 3620 | |10;stanford-crypto-aes;81;81;81;82;83;82;83;82;111;81 06:01:14 INFO - PROCESS | 3620 | |11;stanford-crypto-ccm;123;122;124;119;119;121;124;129;147;131 06:01:14 INFO - PROCESS | 3620 | |12;stanford-crypto-pbkdf2;160;164;173;168;159;160;160;160;157;159 06:01:14 INFO - PROCESS | 3620 | |13;stanford-crypto-sha256-iterative;68;64;64;62;62;62;64;60;61;61 06:01:14 INFO - PROCESS | 3620 | __end_tp_report 06:01:14 INFO - PROCESS | 3620 | __start_cc_report 06:01:14 INFO - PROCESS | 3620 | _x_x_mozilla_cycle_collect,1652 06:01:14 INFO - PROCESS | 3620 | __end_cc_report 06:01:14 INFO - PROCESS | 3620 | __startTimestamp1465304474928__endTimestamp 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | ------- Summary: start ------- 06:01:14 INFO - PROCESS | 3620 | Number of tests: 14 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.62 (1.5%) stddev-sans-first:1.69 06:01:14 INFO - PROCESS | 3620 | Values: 110.0 105.0 109.0 110.0 110.0 111.0 109.0 110.0 109.0 109.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.00 stddev:18.16 (12.0%) stddev-sans-first:18.91 06:01:14 INFO - PROCESS | 3620 | Values: 154.0 125.0 139.0 153.0 125.0 149.0 154.0 129.0 183.0 131.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 06:01:14 INFO - PROCESS | 3620 | Values: 160.0 160.0 160.0 159.0 160.0 163.0 160.0 161.0 160.0 161.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:17.88 (23.8%) stddev-sans-first:18.62 06:01:14 INFO - PROCESS | 3620 | Values: 73.0 74.0 75.0 129.0 75.0 77.0 75.0 75.0 98.0 75.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:84.00 stddev:21.92 (26.1%) stddev-sans-first:22.66 06:01:14 INFO - PROCESS | 3620 | Values: 84.0 86.0 122.0 84.0 84.0 85.0 129.0 85.0 84.0 137.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:01:14 INFO - PROCESS | 3620 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 06:01:14 INFO - PROCESS | 3620 | Values: 147.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 148.0 146.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 06:01:14 INFO - PROCESS | 3620 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:0.88 (1.6%) stddev-sans-first:0.87 06:01:14 INFO - PROCESS | 3620 | Values: 54.0 52.0 52.0 54.0 54.0 54.0 53.0 53.0 52.0 53.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:1.84 (2.9%) stddev-sans-first:1.94 06:01:14 INFO - PROCESS | 3620 | Values: 63.0 64.0 63.0 62.0 63.0 62.0 67.0 63.0 66.0 61.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:82.00 stddev:9.27 (11.3%) stddev-sans-first:9.74 06:01:14 INFO - PROCESS | 3620 | Values: 81.0 81.0 81.0 82.0 83.0 82.0 83.0 82.0 111.0 81.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:124.00 stddev:8.37 (6.8%) stddev-sans-first:8.81 06:01:14 INFO - PROCESS | 3620 | Values: 123.0 122.0 124.0 119.0 119.0 121.0 124.0 129.0 147.0 131.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:160.00 stddev:4.94 (3.1%) stddev-sans-first:5.19 06:01:14 INFO - PROCESS | 3620 | Values: 160.0 164.0 173.0 168.0 159.0 160.0 160.0 160.0 157.0 159.0 06:01:14 INFO - PROCESS | 3620 | 06:01:14 INFO - PROCESS | 3620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:2.30 (3.7%) stddev-sans-first:1.48 06:01:14 INFO - PROCESS | 3620 | Values: 68.0 64.0 64.0 62.0 62.0 62.0 64.0 60.0 61.0 61.0 06:01:14 INFO - PROCESS | 3620 | -------- Summary: end -------- 06:01:14 INFO - PROCESS | 3620 | 06:01:15 INFO - TEST-INFO | 3620: exit 0 06:01:15 INFO - TEST-OK | kraken | took 61817ms 06:01:15 INFO - SUITE-END | took 1178s 06:01:16 INFO - Completed test suite (00:19:38) 06:01:16 INFO - javascript benchmark 06:01:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3176.936461270773, 3177.031005543309, 3177.7298929590984, 3214.903552893414, 3233.110894504013, 5297.4437684043105, 5335.439778823216, 5473.397926228112, 5544.695041772701, 5578.86052848679, 5499.1476321170185, 5520.06158952978, 5528.944710552893, 5569.387367389584, 5615.157726341051, 4933.062718083562, 4987.700737955734, 5027.798888044492, 5033.949660503385, 5174.922376164361, 5044.646874718771, 5076.64463487556, 5110.948890511085, 5122.667026643257, 5130.4613015633195, 4891.1195984722735, 4953.257011448293, 4955.405351357824, 5005.824796132154, 5031.622628302892, 4968.304437378733, 4972.055309491221, 4974.60203183748, 4984.526469985346, 5044.066847633163, 4987.600991920674, 5004.549590536869, 5007.824726134568, 5028.748562571894, 5031.396232452129, 5309.681419114827, 5406.837794866121, 5451.155070964007, 5532.889342213173, 5533.778648854041, 6031.665749321902, 6048.184499972633, 6050.939490605082, 6052.668273540387, 6111.327753947106, 6059.731783994567, 6073.459656790947, 6081.553553233586, 6082.139827336667, 6105.694715264219, 5407.134858422673, 5436.184572314145, 5482.150266708666, 5496.477834605706, 5511.063119269734, 6037.893397483076, 6041.795780758128, 6041.846483526376, 6081.543884208613, 6091.299500557404, 5646.2942132233475, 5833.445822646927, 5842.0, 5846.064629659234, 5850.5612079094235, 5741.397153298927, 5775.595708300379, 5813.912791308134, 5825.76696932118, 5827.796027139115, 5756.251687280626, 5783.306003279633, 5805.883882322414, 5806.274215723035, 5808.796692115756, 5636.774529018793, 5653.321601407775, 5811.3026436827, 5815.9709201453725, 5838.9124163137585, 4395.472543294825, 4401.735895846259, 4403.669724770655, 4428.3800267962515, 4446.221911165598, 3929.8035098244973, 3938.1532970410926, 3946.7631942083567, 3953.6244056814558, 3971.6624086952356, 5428.4842939920645, 5463.235147079412, 5478.178273258964, 5510.173473978935, 5524.751386187631, 5818.156367326798, 5841.182234487175, 5841.970790146107, 5869.765209391577, 5914.408559144051, 5435.184722291688, 5444.047291723932, 5446.836594902159, 5451.427600102012, 5485.725713714378, 4968.925466118011, 5032.018756342478, 5057.291979122926, 5059.87350316245, 5105.234214867725, 6101.156499726972, 6111.227117700271, 6113.111460343413, 6113.202667687823, 6144.324124346318, 5953.91069133972, 5957.046872500379, 5958.731857066529, 5959.0763431668165, 5959.433853783884, 5907.556933230111, 5979.22270104901, 5992.580519363602, 6011.458968692838, 6102.4507794298725, 5764.42355764437, 5806.0, 5807.041838096667, 5813.6221145625395, 5813.76744930198, 5885.764569417175, 5914.319853216935, 5940.405959404025, 5943.7028148591535, 5946.108083787466, 5606.074997625509, 5633.464820842013, 5637.943620563742, 5706.572007099568, 5740.425957404226, 5735.569832262514, 5736.799212027559, 5741.741621626953, 5743.655380677173, 5759.193712880116, 5458.263134476953, 5623.156526521055, 5627.521660658726, 5634.85912852182, 5639.7744090237575, 5756.366799651951, 5804.071348584206, 5825.213596164633, 5907.556933229939, 5910.763569457174, 5748.252727145445, 5749.252597162342, 5756.856078598069, 5758.107493338539, 5803.245578074823], "value": 5415.696594534403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.9844753881154, 624.0514418084515, 629.6473974574236, 638.9265234498031, 644.2719726708822, 31477.0, 43635.34546981794, 44945.0, 45020.77489612551, 48268.75865620676, 45611.31583026249, 46137.0, 46169.538304616945, 46220.53779462205, 46224.3066354005, 8657.177568131017, 8874.86687699685, 8874.955625221864, 8875.245604123656, 8882.644694212224, 8746.737597872074, 8882.156195161482, 8882.511461869595, 8886.333524985619, 8886.511241881693, 8888.644454221823, 8947.77630559238, 8955.596998135066, 8956.596953137092, 8962.820743585124, 8817.382783205177, 8853.911460885438, 8872.201501864798, 8875.156860098281, 8875.245604123656, 8690.826183476294, 8794.69218577353, 8795.604197811113, 8797.29621630268, 8804.163604457566, 41395.1720965582, 41784.79107604473, 41885.1622967542, 42044.0, 42069.789651051855, 3466.5248783784464, 4003.3594624860175, 4175.603317684815, 4274.957250427487, 4345.891352716176, 32425.0, 32553.83723081393, 33016.33967320664, 33808.6619133808, 34017.48973765395, 4060.817263223162, 4078.3882417637296, 4082.3672330788777, 4133.338665813486, 4161.771102589357, 358442.0, 362412.0, 362519.9999999974, 362590.0, 363847.0, 51284.74357628263, 51814.740926295126, 53214.20178697323, 59372.32824522821, 59974.40025599775, 64082.67958660177, 64097.679511602146, 64240.0, 64251.03623445652, 64307.0, 15978.360865565479, 16159.43441979525, 16174.353025878832, 16176.0, 16210.35158593643, 11700.414979251003, 12483.56307529232, 12570.497180112876, 12672.49310027607, 12703.491860325668, 18161.273549058154, 18245.543861403305, 18259.360922367654, 18301.54246143857, 18369.7244541332, 6131.816045518642, 6238.875222495525, 6268.310485846553, 6372.904406433907, 6388.201474815648, 966.1739212972948, 1078.449990504848, 1084.4902895639036, 1101.1686176936362, 1177.181858608259, 33438.66561334355, 33490.66509334924, 33523.83238083843, 33650.0, 33762.66237337644, 1131.3438205840594, 1135.2053562506278, 1154.7228665120479, 1183.3018519073787, 1202.6512311429587, 17378.304867805145, 17534.298628054734, 17567.73648395275, 17681.292748290183, 18360.806317954517, 490670.0, 494969.0, 495230.0, 496087.0, 503273.0, 58922.0, 59718.40281597216, 59785.10322345168, 59958.0, 59973.700131499936, 1282.7049778550986, 1300.0704496285011, 1303.9869601303865, 1390.7496650602786, 1442.5528086293282, 25879.61180582255, 33774.0, 34316.82841585776, 36112.27775444529, 36588.0, 57848.42151578599, 58419.70790146022, 58567.4143258579, 58605.120923185335, 58618.706906465195, 469841.0, 482424.0, 483797.0, 770324.0, 795767.0, 25777.355566110997, 26098.60852087258, 44408.77795611001, 46209.306860397795, 47504.049919002115, 48484.757576213306, 50241.0, 50532.747336263084, 50980.37263122297, 51804.0, 42390.57609423866, 42589.0, 43545.78227108844, 44464.77767611271, 44849.77575112104, 42490.0, 42522.149557008066, 42703.5729642712, 43086.56913430826, 43376.56623433851, 43081.0, 43962.56037439585, 44292.55707443013, 44319.77840110779, 44328.778356108014, 36924.44613330749, 37966.43050354302, 38635.61364386432, 39234.0, 39569.0, 29233.26916827011, 29425.0, 29678.0, 29682.211968665903, 30123.69876301209], "value": 20810.374131921853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2064746621957, 396.69652715672504, 397.3840547151914, 403.43317638717605, 419.09266438161364, 14855.55433336999, 17997.190126444308, 18455.44633660989, 19617.411477655656, 19638.214471421143, 15241.771373429407, 17769.466915992507, 18233.54416139597, 18381.0, 18400.631987360244, 5510.476504732054, 5672.943270567303, 5684.346300175471, 5722.399148089453, 5728.283964504437, 4077.368007958771, 5542.5565954723725, 5640.323161220659, 5918.0, 6228.688565571726, 6163.229596300463, 6199.938000619981, 6202.255729312466, 6224.284207316148, 6238.781642642509, 6016.067509536029, 6257.499400047986, 6312.116303717483, 6314.7474101035905, 6314.810555683314, 5260.8684782880355, 5549.084401073818, 5561.304836895388, 5566.55467562594, 5570.387257401682, 22409.775902240934, 22854.08583656652, 22951.88524057369, 22994.425139371484, 23007.654885176737, 2299.0918587158144, 2394.4253379188867, 2525.2802951158833, 2546.070684200272, 2550.8979640814346, 13763.655908602364, 14194.787078193733, 14195.716085678228, 14321.212333321662, 14668.193249371281, 1947.552063025512, 1976.723258743777, 1991.1438081624894, 2026.5642886779412, 2037.2869495676543, 71104.0, 74391.62804185999, 75258.24741752566, 78359.21640783576, 78765.0, 10151.137153342048, 10246.231532635082, 10778.94610526958, 10932.56269749201, 11179.608713695145, 15350.155741434104, 15372.0, 15399.07605543671, 15428.922855385652, 15443.613909652124, 7704.730334438268, 8073.0, 8073.192680731997, 8167.550784706779, 8186.713465028695, 6802.802682739105, 7581.696732130653, 7675.731349402744, 7773.961130194313, 7800.375969922393, 4328.870133895988, 4626.537346265347, 4629.6990695605355, 4703.623710103184, 4755.429348478136, 1934.6264152451918, 1974.4076776966851, 1980.4157773456866, 1991.71120187572, 1999.6800511918022, 880.9163129502687, 968.5931908598405, 984.886738025122, 995.2088089968493, 1033.2973577967055, 18391.172397242157, 18574.25702971866, 18734.437966861016, 18984.14571344293, 19073.237070517025, 1016.6035246253966, 1029.161233594618, 1055.762453447968, 1071.3678929431674, 1082.6751974407803, 8689.522076285864, 10484.108850747773, 10711.625093121858, 10763.78472430547, 10774.461276936121, 497326.0, 501336.0, 505510.0, 511948.0, 512505.0, 95986.0, 100256.49871750595, 100264.49867750761, 100301.49849250707, 100713.49643251736, 1039.77644806367, 1073.179018051176, 1086.2124959404528, 1096.780643871229, 1099.0218705352243, 17326.88282178372, 17455.0, 17461.738073929155, 17658.646827063643, 17805.821941780418, 34502.29012971562, 38372.42441363438, 39932.600673992885, 43331.78334108309, 43920.56079439165, 56565.151522726366, 57074.714626426605, 59111.704441477516, 59352.0, 59389.0, 8374.413791034813, 8515.48907065578, 8732.172022299746, 8890.777730556787, 8955.462672239686, 12888.677783055498, 13152.80270795958, 13222.471101155847, 13630.250336231602, 13815.032947693566, 11450.198486105892, 11662.94168529152, 11777.941110294394, 11966.58116965902, 11984.161108722654, 11454.599089031844, 11460.0, 11629.941850290694, 11680.299182049104, 11754.353510557, 11693.356865372487, 11715.414229288672, 11911.3448760319, 11968.341741204318, 11989.700257493632, 8502.957485212535, 8606.870896936676, 8645.827083458422, 8709.564521774013, 8798.296136308953, 8924.018357980747, 11352.375619340684, 11676.0, 11696.239744416585, 11805.409729513662], "value": 9299.516294013913, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.2138777427426, 1514.8939574229805, 1539.1303913288991, 1683.3182561062774, 1824.31588154442, 8481.575921203937, 8604.354673399497, 8614.440061396013, 8989.235914947221, 8998.370114092017, 8705.73882783516, 8934.15125563072, 8941.552922353889, 8941.821163576724, 8974.237189838856, 2065.638513260181, 2094.8219401350902, 2095.8008989146006, 2374.6675465434855, 2408.036785285882, 2342.0046480245915, 2378.7502312257225, 2392.7487613800563, 2421.8425802322795, 2426.114468219096, 2364.8226383021256, 2370.5614461324626, 2385.189035727852, 2393.5930891748444, 2439.8048156147465, 2053.938381848547, 2337.1586228957563, 2395.4969456414174, 2426.38127277544, 2426.6602675625427, 2361.9409514762096, 2420.685310909588, 2429.7327293997646, 2430.793382562484, 2432.647266146399, 9030.142136497023, 9093.40892841963, 9095.7271281861, 9097.90902090984, 9106.86339704905, 5297.894042119136, 5438.864028399322, 5443.836684899459, 5449.509544141007, 5452.754626041838, 3316.502524621302, 3332.800031998088, 3504.5093686883856, 3506.281212351462, 3555.8933232002823, 1213.1568559850907, 1219.8658147603755, 2050.9794902051085, 2106.2101711858054, 2109.135254545629, 12035.518579256819, 12117.818232726517, 12128.211666241667, 12135.93932030343, 12142.878571214264, 4454.599086082203, 4528.88677783058, 4614.146382919171, 4625.6530760192445, 4629.0973260214605, 9377.1091746284, 9382.5308734563, 9386.90613093874, 9390.812183756287, 9403.106704863027, 5233.659812112201, 5235.05768961583, 5243.921341179809, 5252.816151434758, 5261.053010458078, 4466.620337271368, 4833.73414462208, 4902.48523904992, 4970.826021089245, 4972.353594032825, 3824.7513911595656, 3832.0, 3892.338302488584, 3902.9609703902597, 3927.5483319418063, 1147.7417581044365, 1148.4602236948622, 1174.1780753472603, 1175.7707247086737, 1185.5080141741253, 997.4065431068502, 1014.8274793285159, 1015.9644412445529, 1021.0759262867117, 1027.912627426677, 6017.969910150508, 6046.18376519173, 6056.606320589148, 6231.2522497300615, 6297.4017468340435, 454.6998980672806, 461.17834553513086, 467.2873867352315, 471.4531143873091, 473.6305681568382, 4272.081502476983, 4296.076343586144, 4325.940144664577, 4333.71830830995, 4345.500267469219, 11123.0, 11496.252743571642, 11584.304941703525, 11593.594224202112, 11601.303921764722, 10711.089557387553, 11077.612283570037, 11501.654950351503, 11501.712457188638, 11504.53981840717, 8386.454880432751, 8501.489910605384, 8509.319254459504, 8557.572121393905, 8589.355798315151, 6223.844403889939, 6415.262244841903, 6467.676616169267, 6468.5472016958365, 6616.172978377703, 10212.795744084928, 10480.109190718875, 10715.24993250465, 10722.249442538947, 10725.80121075162, 10783.892161078289, 10877.021068103908, 10894.400807955639, 10902.836457452986, 10905.0, 7403.407727381689, 7784.844303113793, 7884.21157884207, 7958.323542498721, 8002.03975522941, 8997.100289971213, 8997.2455371202, 9105.0, 9113.817723645623, 9119.726408207764, 7752.573608451589, 7992.440529163136, 8009.91990080115, 8012.399070069651, 8109.067457242257, 7773.37812974972, 7855.84288314242, 7908.683652653829, 7969.551186870178, 8019.799505012421, 7357.632118393952, 7366.263373662591, 7435.293647103733, 7448.478606497493, 7464.440166987606, 5271.0, 5402.918956215582, 5423.996560636295, 5457.508824205841, 5509.338879334506, 5309.389420216725, 5418.0, 5455.0726376515295, 5478.616496845182, 5537.5569954404355], "value": 4695.843107144612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.4070040774771, 330.3953764610764, 332.78202777180945, 333.7030043261497, 338.9983050084749, 5253.89492210156, 5291.788328466857, 5295.841124766253, 5298.735063246837, 5303.23103150043, 5275.525202731754, 5286.286351342567, 5286.947130528693, 5294.100002999489, 5296.311479507668, 4011.699122565805, 4112.115895082557, 4126.958730412703, 4165.666986564301, 4184.560621134783, 4062.573429789874, 4116.197341518405, 4140.8964775880695, 4142.130152667944, 4174.726708353951, 4055.9797201013953, 4059.776712280823, 4087.81604827782, 4088.9591104089022, 4107.8973025674295, 3869.671077958377, 3938.3895496198134, 4031.8387264509383, 4058.7564746115327, 4120.649744771698, 3584.372734771405, 3588.4796704477967, 3589.6948759355487, 3590.694790942773, 3600.71194304455, 4994.500549945013, 4997.525235102659, 4999.700137936554, 5000.349954505891, 5048.1670524363435, 4447.62195213404, 4532.410786597754, 4631.258998560248, 4682.438107427097, 4717.410323709536, 5359.464053594609, 5406.405295417501, 5423.376311724162, 5429.891402171974, 5457.972710136424, 3960.5643379228263, 3963.346047902093, 3969.0474286171398, 3986.123052928351, 3990.74060186087, 5422.91865622016, 5605.73870879053, 5614.035087719307, 5666.121751128581, 5684.0, 4036.455078564415, 4060.0864805418546, 4069.2268468990796, 4074.5721699221153, 4093.85671501496, 4139.19285739278, 4151.543330233671, 4151.813168407429, 4156.688248381323, 4165.687573432005, 4487.0, 4682.765861706901, 4688.97655511727, 4701.623870090384, 4752.40794333902, 5416.810411635653, 5470.480304371078, 5490.752916118784, 5510.437646494399, 5531.45119366578, 1388.1462900316233, 1411.5200831717266, 1413.3286688822727, 1413.5829930170419, 1415.6248594122567, 899.6671231644202, 915.9221466175317, 928.9827638735709, 956.0917128727737, 958.6357184269933, 5196.792128314825, 5205.3863302376385, 5212.947870521246, 5229.398619158769, 5236.607254455855, 5652.349979752299, 5659.915101273484, 5661.915071273934, 5668.781212039431, 5681.931756851254, 5212.947870521322, 5300.867478313073, 5311.3891902431715, 5353.491418315254, 5409.404965453797, 2967.4658561459146, 2979.7914146010003, 3015.7888947773445, 3021.3957208558377, 3041.9087427377212, 5659.660420374791, 5711.8000869969355, 5875.324337701134, 5886.0, 5888.646681199141, 5778.093229234342, 5794.913076303858, 5799.014167591519, 5815.76736930518, 5818.389069147678, 5708.971455142698, 5746.5233533712335, 5749.540036797046, 5759.0, 5806.2451881255165, 5338.8932221356135, 5600.635958662837, 5617.971910140586, 5653.971730141323, 5697.601167918206, 5563.859408821263, 5581.795190899491, 5590.273264475592, 5604.523615492566, 5623.606347555796, 5734.541236701138, 5785.739641716049, 5787.334456537552, 5798.5651076168615, 5820.185174075548, 3921.92156156881, 4152.501699796044, 4155.690957348425, 4166.145940082337, 4174.123434078756, 5614.606977511535, 5629.0, 5639.718014099197, 5639.7744090237575, 5664.688442135722, 5301.310829592283, 5468.0, 5490.3528941318245, 5499.230107784833, 5502.862428439321, 5471.6169868108855, 5488.4237155098135, 5496.258005169251, 5500.80747173847, 5506.669599824023, 5200.97399513, 5261.3686357637325, 5407.459254074561, 5427.294451721409, 5430.348358197041, 5567.1350097716095, 5577.860553486195, 5586.832395027993, 5588.497035266845, 5611.0, 5421.891562168814, 5422.671445495879, 5440.183972404171, 5454.9271276914515, 5480.862978425571], "value": 4199.523099316296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8453740177163, 714.392766148774, 750.2160242546538, 789.1950210785, 802.5946896817106, 13928.860711392883, 15343.079415235079, 15352.539423817276, 15371.84628153718, 15395.615109622237, 14299.356528956196, 14352.784708229385, 14410.423583056692, 14440.0, 14496.710065798678, 679.8028571714196, 796.6693822063866, 816.7345612675874, 817.8241678039235, 830.0703212402118, 824.1058451580013, 826.5040975414763, 829.0093338460542, 829.4442723375353, 829.8921140251758, 872.7948932000975, 874.6763697431927, 874.9981271444193, 875.089906497242, 875.5753459572103, 700.9824754381156, 712.2414628420742, 834.0, 854.5086575219211, 865.4071960706905, 622.3465361370543, 625.2247213455328, 625.5089754542707, 625.809128215894, 625.9906101408483, 14622.415103395851, 14637.6340591485, 14674.853251467455, 14692.338844752012, 14697.706045879022, 14013.78979315301, 14343.56969290923, 14355.71288574233, 14440.927795361062, 14559.70880582393, 11456.4844581994, 11486.885131148749, 11663.066954643607, 11734.0, 11737.413129343498, 3851.768893866377, 4395.824167033315, 4399.23013472641, 4447.799849006802, 4618.030213655136, 72648.0, 73140.0, 73186.0, 73197.0, 73740.63129684371, 10298.330608510572, 10516.26386152962, 10683.519241634145, 10854.891451085388, 10896.147654898687, 17895.10524473797, 17983.73024404635, 18001.09994500296, 18057.638847223243, 18157.818421815613, 8469.957650211833, 8523.48859068458, 8535.658573656985, 8546.529940853312, 8565.229129378262, 4769.523047695203, 4837.591602297471, 4895.828645997373, 4904.43598986114, 4914.0, 3370.3090866372336, 3456.8962931112105, 3458.844352004166, 3460.2214501736908, 3469.809160496197, 550.6052248712849, 622.7477871462065, 638.5211091681239, 646.3891622416771, 664.2626684380334, 604.8729766748944, 705.946780175742, 709.3155105323284, 755.5013690963938, 804.4770898915751, 10587.84118238227, 10877.044064411435, 10946.56213751457, 11031.724206894893, 11106.944465277784, 687.669918439152, 705.1855107351017, 718.6011763471323, 749.868772964729, 785.7564155111819, 4751.738654373973, 5058.519440653132, 5133.12736834739, 5229.869253268699, 5249.42256351801, 92851.0, 95919.52040239754, 95952.0, 109571.45214273878, 114103.0, 93102.53448732712, 95358.0, 97092.51453742827, 98390.0, 98440.50779746055, 54311.0, 86220.56889715636, 87981.0, 89356.10643893608, 90942.0, 9945.602175912882, 9975.401475911469, 9980.301378903407, 10057.0, 10084.647037353658, 50864.745676271385, 51348.22977655413, 51778.223326650885, 52173.478265216865, 52296.21555676592, 68705.65647171732, 68721.65639171773, 74782.0, 75820.0, 77120.0, 12525.686857828627, 12931.418086185957, 12969.546065888026, 13169.934150329187, 13354.93322533381, 14671.70656586841, 14899.404023838924, 14970.925145374204, 15208.46770363032, 15406.0, 14145.787813182606, 14241.50154744579, 14487.130772153705, 14603.415863365772, 14643.56069317922, 13766.793498097337, 14094.78857817113, 14186.574402767934, 14275.571732848031, 14590.708185836436, 12846.486140554272, 13963.930180349033, 14040.929795350958, 14047.36786844574, 14078.0, 10678.199135064746, 10753.062707124414, 11074.889251107386, 11205.887941120485, 11341.149413794163, 10596.223422708965, 11189.888101118884, 11281.153913456359, 11320.716982075513, 11341.546338146713], "value": 7530.670974916612, "unit": "score"}], "name": "dromaeo_css", "value": 7334.4008139275575, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 109.0, 110.0, 110.0, 111.0, 109.0, 110.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 139.0, 153.0, 125.0, 149.0, 154.0, 129.0, 183.0, 131.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 163.0, 160.0, 161.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 129.0, 75.0, 77.0, 75.0, 75.0, 98.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 122.0, 84.0, 84.0, 85.0, 129.0, 85.0, 84.0, 137.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 148.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 54.0, 54.0, 54.0, 53.0, 53.0, 52.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 63.0, 62.0, 67.0, 63.0, 66.0, 61.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 82.0, 83.0, 82.0, 83.0, 82.0, 111.0, 81.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 124.0, 119.0, 119.0, 121.0, 124.0, 129.0, 147.0, 131.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 173.0, 168.0, 159.0, 160.0, 160.0, 160.0, 157.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 64.0, 62.0, 62.0, 62.0, 64.0, 60.0, 61.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1503.9, "alertThreshold": 2.0}]} 06:01:16 INFO - Return code: 0 06:01:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:16 ERROR - # TBPL SUCCESS # 06:01:16 INFO - Running post-action listener: _resource_record_post_action 06:01:16 INFO - ##### 06:01:16 INFO - ##### Finished run-tests step (success) 06:01:16 INFO - ##### 06:01:16 INFO - Running post-run listener: _resource_record_post_run 06:01:16 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7942144; Write bytes: 433741824; Read time: 2424; Write time: 455732 06:01:16 INFO - TinderboxPrint: CPU usage
13.1% 06:01:16 INFO - TinderboxPrint: I/O read bytes / time
7,942,144 / 2,424 06:01:16 INFO - TinderboxPrint: I/O write bytes / time
433,741,824 / 455,732 06:01:16 INFO - TinderboxPrint: CPU idle
8,297.1 (86.8%) 06:01:16 INFO - TinderboxPrint: CPU user
1,206.3 (12.6%) 06:01:16 INFO - TinderboxPrint: Swap in / out
0 / 0 06:01:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15052800; Read time: 0; Write time: 6160 06:01:16 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 6180864; Write bytes: 418689024; Read time: 2384; Write time: 449572 06:01:16 INFO - Running post-run listener: _upload_blobber_files 06:01:16 INFO - Blob upload gear active. 06:01:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:01:17 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:18 INFO - (blobuploader) - INFO - Done attempting. 06:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:23 INFO - (blobuploader) - INFO - Done attempting. 06:01:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:01:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:01:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:24 INFO - (blobuploader) - INFO - Done attempting. 06:01:24 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:24 INFO - Return code: 0 06:01:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10eccb0aaef7434a0bccacdb729d892a60f2d0160558c3024bb92928ac91f14caabe432d66ae9fb98d986759761447238dd051c754610793d619f18c3e96593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/775adbb3b3d26730c7b64bf4bb36a163012b15be3c962117aedff63990a35b156fddc070b4e42845897b5317f7d5ffde0ea4f167a87dfcd2067b46179a7c4781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660df5a4b76194e7f9c532aca281ee82e6157a4bf7771dcc340d9c7dd345427651167d11daf448bac827c3ed5d83e852a31fe87ccc179bd75a31f70ec3bf0648"} 06:01:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:24 INFO - Contents: 06:01:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10eccb0aaef7434a0bccacdb729d892a60f2d0160558c3024bb92928ac91f14caabe432d66ae9fb98d986759761447238dd051c754610793d619f18c3e96593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/775adbb3b3d26730c7b64bf4bb36a163012b15be3c962117aedff63990a35b156fddc070b4e42845897b5317f7d5ffde0ea4f167a87dfcd2067b46179a7c4781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660df5a4b76194e7f9c532aca281ee82e6157a4bf7771dcc340d9c7dd345427651167d11daf448bac827c3ed5d83e852a31fe87ccc179bd75a31f70ec3bf0648"} 06:01:24 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:24 INFO - Copying logs to upload dir... 06:01:24 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.065709 ========= master_lag: -0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-07 06:01:24.231314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 06:01:24.236280) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10eccb0aaef7434a0bccacdb729d892a60f2d0160558c3024bb92928ac91f14caabe432d66ae9fb98d986759761447238dd051c754610793d619f18c3e96593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/775adbb3b3d26730c7b64bf4bb36a163012b15be3c962117aedff63990a35b156fddc070b4e42845897b5317f7d5ffde0ea4f167a87dfcd2067b46179a7c4781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660df5a4b76194e7f9c532aca281ee82e6157a4bf7771dcc340d9c7dd345427651167d11daf448bac827c3ed5d83e852a31fe87ccc179bd75a31f70ec3bf0648"} build_url:https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/UMXrNkcDRqaGCo5MUHcyTg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10eccb0aaef7434a0bccacdb729d892a60f2d0160558c3024bb92928ac91f14caabe432d66ae9fb98d986759761447238dd051c754610793d619f18c3e96593b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/775adbb3b3d26730c7b64bf4bb36a163012b15be3c962117aedff63990a35b156fddc070b4e42845897b5317f7d5ffde0ea4f167a87dfcd2067b46179a7c4781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/660df5a4b76194e7f9c532aca281ee82e6157a4bf7771dcc340d9c7dd345427651167d11daf448bac827c3ed5d83e852a31fe87ccc179bd75a31f70ec3bf0648"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 06:01:24.271480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 06:01:24.275092) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465303089.251511-1854854084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 06:01:24.356936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 06:01:24.357424) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 06:01:24.357903) ========= ========= Total master_lag: -0.11 =========