builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1467066403.15 results: success (0) buildid: 20160627140517 builduid: c7c5f701e90347e6b023a3355f5c744b revision: d17c6eee724effadd6138dd1ced77bd7beaa4f9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.154093) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.155112) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.155410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.170126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.170402) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 15:26:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.8M=0.001s 2016-06-27 15:26:43 (13.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.337553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.337884) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014328 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.387103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:43.387539) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d17c6eee724effadd6138dd1ced77bd7beaa4f9c --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 d17c6eee724effadd6138dd1ced77bd7beaa4f9c --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=8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 15:26:43,643 truncating revision to first 12 chars 2016-06-27 15:26:43,643 Setting DEBUG logging. 2016-06-27 15:26:43,643 attempt 1/10 2016-06-27 15:26:43,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d17c6eee724e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 15:26:43,969 unpacking tar archive at: mozilla-central-d17c6eee724e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663856 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:44.064825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:44.065145) ========= script_repo_revision: d17c6eee724effadd6138dd1ced77bd7beaa4f9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:44.065539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:44.065801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:26:44.076722) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 15:26:44.076990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:26:44 INFO - MultiFileLogger online at 20160627 15:26:44 in /builds/slave/test 15:26:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:26:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:44 INFO - {'append_to_log': False, 15:26:44 INFO - 'base_work_dir': '/builds/slave/test', 15:26:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:26:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:44 INFO - 'branch': 'Firefox-Non-PGO', 15:26:44 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:44 INFO - 'config_files': ('talos/linux_config.py',), 15:26:44 INFO - 'default_actions': ('clobber', 15:26:44 INFO - 'read-buildbot-config', 15:26:44 INFO - 'download-and-extract', 15:26:44 INFO - 'populate-webroot', 15:26:44 INFO - 'create-virtualenv', 15:26:44 INFO - 'install', 15:26:44 INFO - 'run-tests'), 15:26:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:44 INFO - 'download_minidump_stackwalk': True, 15:26:44 INFO - 'download_symbols': 'ondemand', 15:26:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:44 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:44 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:44 INFO - 'installer_path': 'installer.exe', 15:26:44 INFO - 'log_level': 'info', 15:26:44 INFO - 'log_name': 'talos', 15:26:44 INFO - 'log_to_console': True, 15:26:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:26:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:26:44 INFO - 'opt_config_files': (), 15:26:44 INFO - 'pip_index': False, 15:26:44 INFO - 'sps_profile': False, 15:26:44 INFO - 'sps_profile_interval': 0, 15:26:44 INFO - 'suite': 'dromaeojs', 15:26:44 INFO - 'system_bits': '32', 15:26:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:44 INFO - 'title': 'talos-linux64-ix-001', 15:26:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:44 INFO - 'use_talos_json': True, 15:26:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:44 INFO - 'work_dir': 'build'} 15:26:44 INFO - ##### 15:26:44 INFO - ##### Running clobber step. 15:26:44 INFO - ##### 15:26:44 INFO - Running pre-action listener: _resource_record_pre_action 15:26:44 INFO - Running main action method: clobber 15:26:44 INFO - rmtree: /builds/slave/test/build 15:26:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:44 INFO - Running post-action listener: _resource_record_post_action 15:26:44 INFO - ##### 15:26:44 INFO - ##### Finished clobber step (success) 15:26:44 INFO - ##### 15:26:44 INFO - ##### 15:26:44 INFO - ##### Running read-buildbot-config step. 15:26:44 INFO - ##### 15:26:44 INFO - Running pre-action listener: _resource_record_pre_action 15:26:44 INFO - Running main action method: read_buildbot_config 15:26:44 INFO - Using buildbot properties: 15:26:44 INFO - { 15:26:44 INFO - "project": "", 15:26:44 INFO - "product": "firefox", 15:26:44 INFO - "script_repo_revision": "production", 15:26:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:26:44 INFO - "repository": "", 15:26:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:26:44 INFO - "buildid": "20160627140517", 15:26:44 INFO - "pgo_build": "False", 15:26:44 INFO - "basedir": "/builds/slave/test", 15:26:44 INFO - "buildnumber": 535, 15:26:44 INFO - "slavename": "talos-linux64-ix-001", 15:26:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:26:44 INFO - "platform": "ubuntu64_hw", 15:26:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:26:44 INFO - "branch": "mozilla-central", 15:26:44 INFO - "repo_path": "mozilla-central", 15:26:44 INFO - "revision": "d17c6eee724effadd6138dd1ced77bd7beaa4f9c", 15:26:44 INFO - "stage_platform": "linux64", 15:26:44 INFO - "builduid": "c7c5f701e90347e6b023a3355f5c744b", 15:26:44 INFO - "slavebuilddir": "test" 15:26:44 INFO - } 15:26:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:26:44 INFO - Running post-action listener: _resource_record_post_action 15:26:44 INFO - ##### 15:26:44 INFO - ##### Finished read-buildbot-config step (success) 15:26:44 INFO - ##### 15:26:44 INFO - ##### 15:26:44 INFO - ##### Running download-and-extract step. 15:26:44 INFO - ##### 15:26:44 INFO - Running pre-action listener: _resource_record_pre_action 15:26:44 INFO - Running main action method: download_and_extract 15:26:44 INFO - mkdir: /builds/slave/test/build/tests 15:26:44 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')]} 15:26:44 INFO - https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:45 INFO - Downloaded 1361 bytes. 15:26:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:26:45 INFO - Using the following test package requirements: 15:26:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:26:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:26:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'jsshell-linux-x86_64.zip'], 15:26:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:26:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:26:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:26:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:26:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:26:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:45 INFO - https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:47 INFO - Downloaded 22713290 bytes. 15:26:47 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'] 15:26:47 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 15:26:48 INFO - Return code: 0 15:26:48 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 15:26: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')]} 15:26:48 INFO - https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:49 INFO - Downloaded 22713290 bytes. 15:26:49 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'] 15:26:49 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 15:26:51 INFO - Return code: 0 15:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:51 INFO - https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:26:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:52 INFO - Downloaded 14405240 bytes. 15:26:52 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'] 15:26:52 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 15:26:52 INFO - Return code: 0 15:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:52 INFO - https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:26:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b19aXiuZR16YTFEG2rG8JQ/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 15:26:53 INFO - Downloaded 56378524 bytes. 15:26:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:53 INFO - mkdir: /builds/slave/test/properties 15:26:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:53 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:53 INFO - Contents: 15:26:53 INFO - build_url:https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:26:54 INFO - Running post-action listener: _resource_record_post_action 15:26:54 INFO - Running post-action listener: set_extra_try_arguments 15:26:54 INFO - ##### 15:26:54 INFO - ##### Finished download-and-extract step (success) 15:26:54 INFO - ##### 15:26:54 INFO - ##### 15:26:54 INFO - ##### Running populate-webroot step. 15:26:54 INFO - ##### 15:26:54 INFO - Running pre-action listener: _resource_record_pre_action 15:26:54 INFO - Running main action method: populate_webroot 15:26:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:54 INFO - '--tppagecycles', 15:26:54 INFO - '7'], 15:26:54 INFO - 'tests': ['tsvgm']}}, 15:26:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:26:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:26:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['damp', 'tps']}, 15:26:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'tests': ['damp', 'tps']}, 15:26:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['dromaeo_dom']}, 15:26:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['basic_compositor_video']}, 15:26:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:26:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['a11yr', 15:26:54 INFO - 'ts_paint', 15:26:54 INFO - 'tpaint', 15:26:54 INFO - 'sessionrestore', 15:26:54 INFO - 'sessionrestore_no_auto_restore', 15:26:54 INFO - 'tabpaint']}, 15:26:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:26:54 INFO - 'ts_paint', 15:26:54 INFO - 'tpaint', 15:26:54 INFO - 'sessionrestore', 15:26:54 INFO - 'sessionrestore_no_auto_restore', 15:26:54 INFO - 'tabpaint']}, 15:26:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:26:54 INFO - 'ts_paint', 15:26:54 INFO - 'tpaint', 15:26:54 INFO - 'sessionrestore', 15:26:54 INFO - 'sessionrestore_no_auto_restore', 15:26:54 INFO - 'tabpaint']}, 15:26:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:26:54 INFO - 'ts_paint', 15:26:54 INFO - 'tpaint', 15:26:54 INFO - 'sessionrestore', 15:26:54 INFO - 'sessionrestore_no_auto_restore', 15:26:54 INFO - 'tabpaint']}, 15:26:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['a11yr', 15:26:54 INFO - 'ts_paint', 15:26:54 INFO - 'tpaint', 15:26:54 INFO - 'sessionrestore', 15:26:54 INFO - 'sessionrestore_no_auto_restore', 15:26:54 INFO - 'tabpaint']}, 15:26:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['a11yr', 15:26:54 INFO - 'ts_paint', 15:26:54 INFO - 'tpaint', 15:26:54 INFO - 'sessionrestore', 15:26:54 INFO - 'sessionrestore_no_auto_restore', 15:26:54 INFO - 'tabpaint']}, 15:26:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['tsvgx', 15:26:54 INFO - 'tsvgr_opacity', 15:26:54 INFO - 'tart', 15:26:54 INFO - 'tscrollx', 15:26:54 INFO - 'cart']}, 15:26:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:26:54 INFO - 'tsvgr_opacity', 15:26:54 INFO - 'tart', 15:26:54 INFO - 'tscrollx', 15:26:54 INFO - 'cart']}, 15:26:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'talos_options': ['--disable-e10s'], 15:26:54 INFO - 'tests': ['tp5o']}, 15:26:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'tests': ['tp5o']}, 15:26:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'talos_options': ['--disable-e10s', 15:26:54 INFO - '--xperf_path', 15:26:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:54 INFO - 'tests': ['tp5n']}, 15:26:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:54 INFO - 'talos_options': ['--xperf_path', 15:26:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:54 INFO - 'tests': ['tp5n']}}, 15:26:54 INFO - 'talos.zip': {'path': '', 15:26:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:54 INFO - Running post-action listener: _resource_record_post_action 15:26:54 INFO - ##### 15:26:54 INFO - ##### Finished populate-webroot step (success) 15:26:54 INFO - ##### 15:26:54 INFO - ##### 15:26:54 INFO - ##### Running create-virtualenv step. 15:26:54 INFO - ##### 15:26:54 INFO - Running pre-action listener: _resource_record_pre_action 15:26:54 INFO - Running main action method: create_virtualenv 15:26:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:54 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 15:26:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:54 INFO - Using real prefix '/usr' 15:26:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:57 INFO - Installing pip.................done. 15:26:57 INFO - Return code: 0 15:26:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:26:57 INFO - Using env: {'DISPLAY': ':0', 15:26:57 INFO - 'HOME': '/home/cltbld', 15:26:57 INFO - 'LANG': 'en_US.UTF-8', 15:26:57 INFO - 'LANGUAGE': 'en_US:en', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MAIL': '/var/mail/cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SHLVL': '1', 15:26:57 INFO - 'TERM': 'linux', 15:26:57 INFO - 'TMOUT': '86400', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - '_': '/tools/buildbot/bin/python'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 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 15:26:57 INFO - Cleaning up... 15:26:57 INFO - Return code: 0 15:26:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:26:57 INFO - Using env: {'DISPLAY': ':0', 15:26:57 INFO - 'HOME': '/home/cltbld', 15:26:57 INFO - 'LANG': 'en_US.UTF-8', 15:26:57 INFO - 'LANGUAGE': 'en_US:en', 15:26:57 INFO - 'LOGNAME': 'cltbld', 15:26:57 INFO - 'MAIL': '/var/mail/cltbld', 15:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:57 INFO - 'MOZ_NO_REMOTE': '1', 15:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:57 INFO - 'NO_EM_RESTART': '1', 15:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:57 INFO - 'PWD': '/builds/slave/test', 15:26:57 INFO - 'SHELL': '/bin/bash', 15:26:57 INFO - 'SHLVL': '1', 15:26:57 INFO - 'TERM': 'linux', 15:26:57 INFO - 'TMOUT': '86400', 15:26:57 INFO - 'USER': 'cltbld', 15:26:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:57 INFO - '_': '/tools/buildbot/bin/python'} 15:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:57 INFO - Downloading/unpacking psutil>=3.1.1 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:59 INFO - Installing collected packages: psutil 15:26:59 INFO - Running setup.py install for psutil 15:26:59 INFO - building 'psutil._psutil_linux' extension 15:26:59 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 15:26: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 15:26:59 INFO - building 'psutil._psutil_posix' extension 15:26: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 15:27:00 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 15:27:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:00 INFO - Successfully installed psutil 15:27:00 INFO - Cleaning up... 15:27:00 INFO - Return code: 0 15:27:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:27:00 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')]} 15:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 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')]} 15:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:00 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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27:00 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 15:27:00 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 15:27:00 INFO - Using env: {'DISPLAY': ':0', 15:27:00 INFO - 'HOME': '/home/cltbld', 15:27:00 INFO - 'LANG': 'en_US.UTF-8', 15:27:00 INFO - 'LANGUAGE': 'en_US:en', 15:27:00 INFO - 'LOGNAME': 'cltbld', 15:27:00 INFO - 'MAIL': '/var/mail/cltbld', 15:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:00 INFO - 'MOZ_NO_REMOTE': '1', 15:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:00 INFO - 'NO_EM_RESTART': '1', 15:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:00 INFO - 'PWD': '/builds/slave/test', 15:27:00 INFO - 'SHELL': '/bin/bash', 15:27:00 INFO - 'SHLVL': '1', 15:27:00 INFO - 'TERM': 'linux', 15:27:00 INFO - 'TMOUT': '86400', 15:27:00 INFO - 'USER': 'cltbld', 15:27:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:00 INFO - '_': '/tools/buildbot/bin/python'} 15:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:27:00 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 15:27:00 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 15:27:00 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 15:27:00 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 15:27:00 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 15:27:00 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 15:27:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:27:02 INFO - Installing collected packages: mozsystemmonitor 15:27:02 INFO - Running setup.py install for mozsystemmonitor 15:27:02 INFO - Successfully installed mozsystemmonitor 15:27:02 INFO - Cleaning up... 15:27:02 INFO - Return code: 0 15:27:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27: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 15:27: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 15:27:02 INFO - Using env: {'DISPLAY': ':0', 15:27:02 INFO - 'HOME': '/home/cltbld', 15:27:02 INFO - 'LANG': 'en_US.UTF-8', 15:27:02 INFO - 'LANGUAGE': 'en_US:en', 15:27:02 INFO - 'LOGNAME': 'cltbld', 15:27:02 INFO - 'MAIL': '/var/mail/cltbld', 15:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:02 INFO - 'MOZ_NO_REMOTE': '1', 15:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:02 INFO - 'NO_EM_RESTART': '1', 15:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:02 INFO - 'PWD': '/builds/slave/test', 15:27:02 INFO - 'SHELL': '/bin/bash', 15:27:02 INFO - 'SHLVL': '1', 15:27:02 INFO - 'TERM': 'linux', 15:27:02 INFO - 'TMOUT': '86400', 15:27:02 INFO - 'USER': 'cltbld', 15:27:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:02 INFO - '_': '/tools/buildbot/bin/python'} 15:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:02 INFO - Downloading/unpacking jsonschema==2.5.1 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:27:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:04 INFO - Downloading functools32-3.2.3-2.tar.gz 15:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:27:04 INFO - warning: no files found matching '*.txt' 15:27:04 INFO - no previously-included directories found matching 'build' 15:27:04 INFO - no previously-included directories found matching 'dist' 15:27:04 INFO - no previously-included directories found matching '.git*' 15:27:04 INFO - Installing collected packages: jsonschema, functools32 15:27:05 INFO - Running setup.py install for functools32 15:27:05 INFO - warning: no files found matching '*.txt' 15:27:05 INFO - no previously-included directories found matching 'build' 15:27:05 INFO - no previously-included directories found matching 'dist' 15:27:05 INFO - no previously-included directories found matching '.git*' 15:27:05 INFO - Successfully installed jsonschema functools32 15:27:05 INFO - Cleaning up... 15:27:05 INFO - Return code: 0 15:27:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:05 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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27:05 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 15:27:05 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 15:27:05 INFO - Using env: {'DISPLAY': ':0', 15:27:05 INFO - 'HOME': '/home/cltbld', 15:27:05 INFO - 'LANG': 'en_US.UTF-8', 15:27:05 INFO - 'LANGUAGE': 'en_US:en', 15:27:05 INFO - 'LOGNAME': 'cltbld', 15:27:05 INFO - 'MAIL': '/var/mail/cltbld', 15:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:05 INFO - 'MOZ_NO_REMOTE': '1', 15:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:05 INFO - 'NO_EM_RESTART': '1', 15:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:05 INFO - 'PWD': '/builds/slave/test', 15:27:05 INFO - 'SHELL': '/bin/bash', 15:27:05 INFO - 'SHLVL': '1', 15:27:05 INFO - 'TERM': 'linux', 15:27:05 INFO - 'TMOUT': '86400', 15:27:05 INFO - 'USER': 'cltbld', 15:27:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:05 INFO - '_': '/tools/buildbot/bin/python'} 15:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:05 INFO - Downloading/unpacking blobuploader==1.2.4 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:27:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:27:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:07 INFO - Downloading docopt-0.6.1.tar.gz 15:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:08 INFO - Running setup.py install for blobuploader 15:27:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:08 INFO - Running setup.py install for requests 15:27:08 INFO - Running setup.py install for docopt 15:27:08 INFO - Successfully installed blobuploader requests docopt 15:27:08 INFO - Cleaning up... 15:27:08 INFO - Return code: 0 15:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27: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 15:27: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 15:27:08 INFO - Using env: {'DISPLAY': ':0', 15:27:08 INFO - 'HOME': '/home/cltbld', 15:27:08 INFO - 'LANG': 'en_US.UTF-8', 15:27:08 INFO - 'LANGUAGE': 'en_US:en', 15:27:08 INFO - 'LOGNAME': 'cltbld', 15:27:08 INFO - 'MAIL': '/var/mail/cltbld', 15:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:08 INFO - 'MOZ_NO_REMOTE': '1', 15:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:08 INFO - 'NO_EM_RESTART': '1', 15:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:08 INFO - 'PWD': '/builds/slave/test', 15:27:08 INFO - 'SHELL': '/bin/bash', 15:27:08 INFO - 'SHLVL': '1', 15:27:08 INFO - 'TERM': 'linux', 15:27:08 INFO - 'TMOUT': '86400', 15:27:08 INFO - 'USER': 'cltbld', 15:27:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:08 INFO - '_': '/tools/buildbot/bin/python'} 15:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:08 INFO - Running setup.py (path:/tmp/pip-fVeQeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:08 INFO - Running setup.py (path:/tmp/pip-dR_ZnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:08 INFO - Running setup.py (path:/tmp/pip-BO5BJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:09 INFO - Running setup.py (path:/tmp/pip-u4gCBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:09 INFO - Running setup.py (path:/tmp/pip-WafD_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:09 INFO - Running setup.py (path:/tmp/pip-7VOJKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:09 INFO - Running setup.py (path:/tmp/pip-xQ_vI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:09 INFO - Running setup.py (path:/tmp/pip-7D1WZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:09 INFO - Running setup.py (path:/tmp/pip-QSTF58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:09 INFO - Running setup.py (path:/tmp/pip-TPp5FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:09 INFO - Running setup.py (path:/tmp/pip-hZacLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:09 INFO - Running setup.py (path:/tmp/pip-_SzXdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:09 INFO - Running setup.py (path:/tmp/pip-xbWLLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:09 INFO - Running setup.py (path:/tmp/pip-QWQIXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:09 INFO - Running setup.py (path:/tmp/pip-m7L1Pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:09 INFO - Running setup.py (path:/tmp/pip-fzhFZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:10 INFO - Running setup.py (path:/tmp/pip-J0G1ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:10 INFO - Running setup.py install for manifestparser 15:27:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Running setup.py install for mozcrash 15:27:10 INFO - Running setup.py install for mozdebug 15:27:10 INFO - Running setup.py install for mozdevice 15:27:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Running setup.py install for mozfile 15:27:10 INFO - Running setup.py install for mozhttpd 15:27:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Running setup.py install for mozinfo 15:27:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Running setup.py install for mozInstall 15:27:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Running setup.py install for mozleak 15:27:11 INFO - Running setup.py install for mozlog 15:27:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Running setup.py install for moznetwork 15:27:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Running setup.py install for mozprocess 15:27:11 INFO - Running setup.py install for mozprofile 15:27:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Running setup.py install for mozrunner 15:27:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Running setup.py install for mozscreenshot 15:27:11 INFO - Running setup.py install for moztest 15:27:11 INFO - Running setup.py install for mozversion 15:27:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:11 INFO - Cleaning up... 15:27:11 INFO - Return code: 0 15:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27: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 15:27: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 15:27:11 INFO - Using env: {'DISPLAY': ':0', 15:27:11 INFO - 'HOME': '/home/cltbld', 15:27:11 INFO - 'LANG': 'en_US.UTF-8', 15:27:11 INFO - 'LANGUAGE': 'en_US:en', 15:27:11 INFO - 'LOGNAME': 'cltbld', 15:27:11 INFO - 'MAIL': '/var/mail/cltbld', 15:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:11 INFO - 'MOZ_NO_REMOTE': '1', 15:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:11 INFO - 'NO_EM_RESTART': '1', 15:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:11 INFO - 'PWD': '/builds/slave/test', 15:27:11 INFO - 'SHELL': '/bin/bash', 15:27:11 INFO - 'SHLVL': '1', 15:27:11 INFO - 'TERM': 'linux', 15:27:11 INFO - 'TMOUT': '86400', 15:27:11 INFO - 'USER': 'cltbld', 15:27:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:11 INFO - '_': '/tools/buildbot/bin/python'} 15:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:12 INFO - Running setup.py (path:/tmp/pip-EJgoDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:12 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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:12 INFO - Running setup.py (path:/tmp/pip-qcW_NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:12 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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:12 INFO - Running setup.py (path:/tmp/pip-GaM6E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:12 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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:12 INFO - Running setup.py (path:/tmp/pip-fSuIWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:12 INFO - Running setup.py (path:/tmp/pip-rYVeoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:12 INFO - Running setup.py (path:/tmp/pip-tJ2Qaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:12 INFO - Running setup.py (path:/tmp/pip-3ERsF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:12 INFO - Running setup.py (path:/tmp/pip-sFzcpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:12 INFO - Running setup.py (path:/tmp/pip-c4j00w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:12 INFO - Running setup.py (path:/tmp/pip-mFZO2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:12 INFO - Running setup.py (path:/tmp/pip-NbHl84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27: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)) 15:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:12 INFO - Running setup.py (path:/tmp/pip-HSq5uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:13 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)) 15:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:13 INFO - Running setup.py (path:/tmp/pip-tU0Egn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:13 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)) 15:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:13 INFO - Running setup.py (path:/tmp/pip-DnbITV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:13 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)) 15:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:13 INFO - Running setup.py (path:/tmp/pip-VJAAcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:13 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)) 15:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:13 INFO - Running setup.py (path:/tmp/pip-iSaKwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:13 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)) 15:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:13 INFO - Running setup.py (path:/tmp/pip-rnnz1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:15 INFO - Downloading blessings-1.6.tar.gz 15:27:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:15 INFO - Installing collected packages: blessings 15:27:15 INFO - Running setup.py install for blessings 15:27:15 INFO - Successfully installed blessings 15:27:15 INFO - Cleaning up... 15:27:15 INFO - Return code: 0 15:27:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:15 INFO - Reading from file tmpfile_stdout 15:27:15 INFO - Current package versions: 15:27:15 INFO - argparse == 1.2.1 15:27:15 INFO - blessings == 1.6 15:27:15 INFO - blobuploader == 1.2.4 15:27:15 INFO - docopt == 0.6.1 15:27:15 INFO - functools32 == 3.2.3-2 15:27:15 INFO - jsonschema == 2.5.1 15:27:15 INFO - manifestparser == 1.1 15:27:15 INFO - mozInstall == 1.12 15:27:15 INFO - mozcrash == 0.17 15:27:15 INFO - mozdebug == 0.1 15:27:15 INFO - mozdevice == 0.48 15:27:15 INFO - mozfile == 1.2 15:27:15 INFO - mozhttpd == 0.7 15:27:15 INFO - mozinfo == 0.9 15:27:15 INFO - mozleak == 0.1 15:27:15 INFO - mozlog == 3.2 15:27:15 INFO - moznetwork == 0.27 15:27:15 INFO - mozprocess == 0.22 15:27:15 INFO - mozprofile == 0.28 15:27:15 INFO - mozrunner == 6.11 15:27:15 INFO - mozscreenshot == 0.1 15:27:15 INFO - mozsystemmonitor == 0.3 15:27:15 INFO - moztest == 0.7 15:27:15 INFO - mozversion == 1.4 15:27:15 INFO - psutil == 3.1.1 15:27:15 INFO - requests == 1.2.3 15:27:15 INFO - wsgiref == 0.1.2 15:27:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27: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 15:27: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 15:27:15 INFO - Using env: {'DISPLAY': ':0', 15:27:15 INFO - 'HOME': '/home/cltbld', 15:27:15 INFO - 'LANG': 'en_US.UTF-8', 15:27:15 INFO - 'LANGUAGE': 'en_US:en', 15:27:15 INFO - 'LOGNAME': 'cltbld', 15:27:15 INFO - 'MAIL': '/var/mail/cltbld', 15:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:15 INFO - 'MOZ_NO_REMOTE': '1', 15:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:15 INFO - 'NO_EM_RESTART': '1', 15:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:15 INFO - 'PWD': '/builds/slave/test', 15:27:15 INFO - 'SHELL': '/bin/bash', 15:27:15 INFO - 'SHLVL': '1', 15:27:15 INFO - 'TERM': 'linux', 15:27:15 INFO - 'TMOUT': '86400', 15:27:15 INFO - 'USER': 'cltbld', 15:27:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:15 INFO - '_': '/tools/buildbot/bin/python'} 15:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27: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)) 15:27:15 INFO - Cleaning up... 15:27:15 INFO - Return code: 0 15:27:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27: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 15:27: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 15:27:15 INFO - Using env: {'DISPLAY': ':0', 15:27:15 INFO - 'HOME': '/home/cltbld', 15:27:15 INFO - 'LANG': 'en_US.UTF-8', 15:27:15 INFO - 'LANGUAGE': 'en_US:en', 15:27:15 INFO - 'LOGNAME': 'cltbld', 15:27:15 INFO - 'MAIL': '/var/mail/cltbld', 15:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:15 INFO - 'MOZ_NO_REMOTE': '1', 15:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:15 INFO - 'NO_EM_RESTART': '1', 15:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:15 INFO - 'PWD': '/builds/slave/test', 15:27:15 INFO - 'SHELL': '/bin/bash', 15:27:15 INFO - 'SHLVL': '1', 15:27:15 INFO - 'TERM': 'linux', 15:27:15 INFO - 'TMOUT': '86400', 15:27:15 INFO - 'USER': 'cltbld', 15:27:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:15 INFO - '_': '/tools/buildbot/bin/python'} 15:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:27:16 INFO - Cleaning up... 15:27:16 INFO - Return code: 0 15:27:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1436480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', '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 15:27:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:27:16 INFO - Using env: {'DISPLAY': ':0', 15:27:16 INFO - 'HOME': '/home/cltbld', 15:27:16 INFO - 'LANG': 'en_US.UTF-8', 15:27:16 INFO - 'LANGUAGE': 'en_US:en', 15:27:16 INFO - 'LOGNAME': 'cltbld', 15:27:16 INFO - 'MAIL': '/var/mail/cltbld', 15:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:16 INFO - 'MOZ_NO_REMOTE': '1', 15:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:16 INFO - 'NO_EM_RESTART': '1', 15:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:16 INFO - 'PWD': '/builds/slave/test', 15:27:16 INFO - 'SHELL': '/bin/bash', 15:27:16 INFO - 'SHLVL': '1', 15:27:16 INFO - 'TERM': 'linux', 15:27:16 INFO - 'TMOUT': '86400', 15:27:16 INFO - 'USER': 'cltbld', 15:27:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:16 INFO - '_': '/tools/buildbot/bin/python'} 15:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:16 INFO - Downloading/unpacking flake8 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:27:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:27:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:19 INFO - no previously-included directories found matching 'docs/_build' 15:27:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:27:19 INFO - Running setup.py install for pep8 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:19 INFO - no previously-included directories found matching 'docs/_build' 15:27:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:27:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:27:19 INFO - Cleaning up... 15:27:19 INFO - Return code: 0 15:27:19 INFO - Running post-action listener: _resource_record_post_action 15:27:19 INFO - Running post-action listener: _start_resource_monitoring 15:27:19 INFO - Starting resource monitoring. 15:27:19 INFO - ##### 15:27:19 INFO - ##### Finished create-virtualenv step (success) 15:27:19 INFO - ##### 15:27:19 INFO - ##### 15:27:19 INFO - ##### Running install step. 15:27:19 INFO - ##### 15:27:19 INFO - Running pre-action listener: _resource_record_pre_action 15:27:19 INFO - Running main action method: install 15:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:19 INFO - Reading from file tmpfile_stdout 15:27:19 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:19 INFO - Reading from file tmpfile_stdout 15:27:19 INFO - Output received: 15:27:19 INFO - Usage: mozinstall [options] installer 15:27:19 INFO - Options: 15:27:19 INFO - -h, --help show this help message and exit 15:27:19 INFO - -d DEST, --destination=DEST 15:27:19 INFO - Directory to install application into. [default: 15:27:19 INFO - "/builds/slave/test"] 15:27:19 INFO - --app=APP Application being installed. [default: firefox] 15:27:19 INFO - mkdir: /builds/slave/test/build/application 15:27: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'] 15:27: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 15:27:35 INFO - Reading from file tmpfile_stdout 15:27:35 INFO - Output received: 15:27:35 INFO - /builds/slave/test/build/application/firefox/firefox 15:27:35 INFO - Running post-action listener: _resource_record_post_action 15:27:35 INFO - ##### 15:27:35 INFO - ##### Finished install step (success) 15:27:35 INFO - ##### 15:27:35 INFO - ##### 15:27:35 INFO - ##### Running run-tests step. 15:27:35 INFO - ##### 15:27:35 INFO - Running pre-action listener: _resource_record_pre_action 15:27:35 INFO - Running main action method: run_tests 15:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:35 INFO - Python 2.7.3 15:27:35 INFO - Return code: 0 15:27:35 INFO - grabbing minidump binary from tooltool 15:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:35 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 0x14c56f0>, '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 0x14c65f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c6aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:35 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 15:27:35 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 15:27:35 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 15:27:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:35 INFO - Return code: 0 15:27:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:27:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:27:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:27:36 INFO - Return code: 0 15:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 15:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 15:27:36 INFO - Using env: {'DISPLAY': ':0', 15:27:36 INFO - 'HOME': '/home/cltbld', 15:27:36 INFO - 'LANG': 'en_US.UTF-8', 15:27:36 INFO - 'LANGUAGE': 'en_US:en', 15:27:36 INFO - 'LOGNAME': 'cltbld', 15:27:36 INFO - 'MAIL': '/var/mail/cltbld', 15:27:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:36 INFO - 'MOZ_NO_REMOTE': '1', 15:27:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:36 INFO - 'NO_EM_RESTART': '1', 15:27:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:36 INFO - 'PWD': '/builds/slave/test', 15:27:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:36 INFO - 'SHELL': '/bin/bash', 15:27:36 INFO - 'SHLVL': '1', 15:27:36 INFO - 'TERM': 'linux', 15:27:36 INFO - 'TMOUT': '86400', 15:27:36 INFO - 'USER': 'cltbld', 15:27:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651', 15:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:36 INFO - '_': '/tools/buildbot/bin/python'} 15:27:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 15:27:37 INFO - mozversion application_buildid: 20160627140517 15:27:37 INFO - mozversion application_changeset: d17c6eee724effadd6138dd1ced77bd7beaa4f9c 15:27:37 INFO - mozversion application_display_name: Nightly 15:27:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:37 INFO - mozversion application_name: Firefox 15:27:37 INFO - mozversion application_remotingname: firefox 15:27:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:27:37 INFO - mozversion application_vendor: Mozilla 15:27:37 INFO - mozversion application_version: 50.0a1 15:27:37 INFO - mozversion platform_buildid: 20160627140517 15:27:37 INFO - mozversion platform_changeset: d17c6eee724effadd6138dd1ced77bd7beaa4f9c 15:27:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:27:37 INFO - mozversion platform_version: 50.0a1 15:27:37 INFO - using testdate: 1467066457 15:27:37 INFO - actual date: 1467066457 15:27:37 INFO - starting webserver on 'localhost:53148' 15:27:37 INFO - SUITE-START | Running 2 tests 15:27:37 INFO - TEST-START | dromaeo_css 15:27:37 INFO - operating with platform_type : linux_ 15:27:37 INFO - Initialising browser for dromaeo_css test... 15:27:37 INFO - TEST-INFO | started process 312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WX4PV/profile http://localhost:53148/getInfo.html) 15:27:41 INFO - PROCESS | 312 | __metrics Screen width/height:1600/1200 15:27:41 INFO - PROCESS | 312 | colorDepth:24 15:27:41 INFO - PROCESS | 312 | Browser inner width/height: 1024/697 15:27:41 INFO - PROCESS | 312 | __metrics 15:27:42 INFO - PROCESS | 312 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:27:43 INFO - TEST-INFO | 312: exit 0 15:27:43 INFO - Browser initialized. 15:27:43 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:43 INFO - TEST-INFO | started process 396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WX4PV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:56 INFO - PROCESS | 396 | RSS: Main: 174878720 15:27:56 INFO - PROCESS | 396 | 15:28:47 INFO - PROCESS | 396 | 1467066527708 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] 15:30:59 INFO - PROCESS | 396 | Cycle 1(1): loaded http://localhost:53148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53148/tests/dromaeo/cssquery-ext.html) 15:31:00 INFO - PROCESS | 396 | RSS: Main: 274558976 15:31:00 INFO - PROCESS | 396 | 15:34:03 INFO - PROCESS | 396 | Cycle 1(1): loaded http://localhost:53148/tests/dromaeo/cssquery-ext.html (next: http://localhost:53148/tests/dromaeo/cssquery-jquery.html) 15:34:04 INFO - PROCESS | 396 | RSS: Main: 254214144 15:34:04 INFO - PROCESS | 396 | 15:37:06 INFO - PROCESS | 396 | Cycle 1(1): loaded http://localhost:53148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53148/tests/dromaeo/cssquery-mootools.html) 15:37:07 INFO - PROCESS | 396 | RSS: Main: 253792256 15:37:07 INFO - PROCESS | 396 | 15:40:09 INFO - PROCESS | 396 | Cycle 1(1): loaded http://localhost:53148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53148/tests/dromaeo/cssquery-prototype.html) 15:40:09 INFO - PROCESS | 396 | RSS: Main: 260575232 15:40:09 INFO - PROCESS | 396 | 15:43:12 INFO - PROCESS | 396 | Cycle 1(1): loaded http://localhost:53148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53148/tests/dromaeo/cssquery-yui.html) 15:43:13 INFO - PROCESS | 396 | RSS: Main: 233803776 15:43:13 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | Cycle 1(1): loaded http://localhost:53148/tests/dromaeo/cssquery-yui.html (next: http://localhost:53148/tests/dromaeo/cssquery-dojo.html) 15:46:16 INFO - PROCESS | 396 | RSS: Main: 282611712 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | __start_tp_report 15:46:16 INFO - PROCESS | 396 | _x_x_mozilla_page_load 15:46:16 INFO - PROCESS | 396 | _x_x_mozilla_page_load_details 15:46:16 INFO - PROCESS | 396 | |i|pagename|runs| 15:46:16 INFO - PROCESS | 396 | |0;dojo.html;2632.947341053179;2639.234621959632;2678.59821026846;2693.838369697818;2697.8111532192743;4659.440867095945;4717.882052948678;4725;4802.663813533054;4854.05345957538;4791.377120974268;4812.374391329131;4834.516548345164;4856.490068542805;4891.877703057426;4414.02891363901;4444.355568442574;4470.195364834345;4487.282034874421;4590.150822097922;4471.8658440246845;4533.410656614636;4578.97710511447;4616.28447590624;4620.745858977772;4334.544872788343;4513.684042117053;4537.2740361542155;4557.95442045582;4564.269716845305;4379.08039311745;4411.1618792429335;4411.448568928884;4421.8452354167775;4432.578905004052;4366.737995720267;4385.320275357325;4390.846320378803;4428.424304840382;4439.156560253541;4897.363342765418;4908.263760435928;4919.72941488218;4924.359833221694;4931.556159945622;5045.949540504585;5112.693238405707;5175.482451754832;5182.248573956793;5222.973885130588;5247.632665713401;5268.130758424855;5282.471752824726;5283.049051170788;5290;4855.732934688555;4863.051704917578;4900.338454308694;4912;4914.631402644816;5246.213068039825;5246.554042906396;5250;5287.471252874681;5320.14877619579;5039.193729003342;5067.923981140286;5092;5099.490050994871;5099.9490005100215;5136.9743151284;5138.3577052868395;5142.2029585413575;5145.253938179018;5179.689218646893;5032.270320803536;5037.219231019198;5059.038782631288;5093.796248150106;5102.056119617882;5076.923846142311;5077.111505486525;5084.745762711924;5085.9745701271995;5126.871828204325;4396.230659634552;4397.73613583186;4400.669949753781;4418.337249412614;4473.888152796206;3793.525809273841;3807.3527500325013;3823.7896915669903;3833.6933045356864;3873.4189871519498;4499.460064792246;4507.549245075466;4529.456465224194;4539.931901021488;4545.5908968193025;5208.374995000624;5208.427073021964;5218.373795144607;5218.634695571273;5266.473352664703;4429.357743127229;4477.485089214717;4486.842960496432;4496.325551167286;4531.342955271533;4715.41057367829;4736.19484687597;4745.193317136095;4753.168195565762;4803.991161856049;4879.756012199305;4924.187509060965;4928.581070609039;4936.777844996912;4957.082939656175;5066.569341606005;5165.251038599457;5180.559652429586;5269.552088072557;5316.255724198538;4847.830325938575;4872.123017856678;4872.853814385574;4918.655694101379;4954.9752251238515;5160.071187186342;5161.81933632321;5161.993411284763;5174.9482505174465;5183.248428977852;5074.847754567369;5177.585793136464;5213.322268105122;5230.712310822942;5259.868503287448;5106.46382129871;5116.74416279192;5124.385073791169;5127.333446651912;5128.025675121864;5091.312672789126;5092.057969275547;5092.9745351273;5107.6169287302855;5110.693358398508;4878.0975519529;4961.1070007397575;5010.123228435083;5025.145725226647;5095.541401273903;5124.5131712487255;5126.6923984561045;5127.615428842777;5128.051310507568;5146.511081447256;4885.5358740919555;5034.493392289525;5037.874053148701;5043.899122017612;5085.110105731408 15:46:16 INFO - PROCESS | 396 | |1;ext.html;545.2676855147212;578.0664227272955;579.4639958038814;583.9357670656227;592.4164697772693;26121.47757044858;28772.280692982687;39030.414543781866;39709.4334151572;39844.60155398445;41064.58935410645;41506;41527.79236103823;41589.16821663573;41609;7575.166731659513;7720.112187098472;7723.61381930904;7724.227577242259;7726.42051846111;7879.724209652634;7977.641006154708;7980.122186559473;7981.401394895377;7983.800404989864;7935.563544005077;8001.479903806263;8002.039755229381;8002.799930001767;8007.119216886138;7940;7964.123946365895;7983.680652773882;7985.840283194332;7985.96007019967;7625.694972201105;7688.1927397623;7690.884636730453;7694.115176754633;7701.499402538817;39584.40623390651;39744.60255397467;39911;40149.197016059516;40167.59832401697;3222.7905186162825;3369.8652053917813;3524.6475352464804;3671.6695497405362;3768.9811550942068;29114.272143196376;29405;29464.41071178586;29931.551026734618;30838.229044274074;3433.4163192257374;3442.9655703443145;3447.517347571342;3514.279572687593;3555.306715190539;239999;240267;240343;240888;241338.7933060341;31394.21514462157;32495.51256731151;49789.253161202614;49802.50197497979;49981.75009125004;34023.31953360919;34064.82967585196;34136.146596334795;34210.14474638154;34221;12285.75428491443;12294.75410491785;12332.445039973223;12343.629691109101;12359.752804943852;10631.787364252827;10711.196660250356;10713.892861071445;10714.19643526723;10721.035106840422;7886;7896.644650990719;7916.802079947932;7961.482503637245;7997.640106195236;3098.4422803895513;3118.875244990175;3154.8738050477723;3159.699828516287;3210.0530343548708;870.5168631409501;873.4409977614332;906.6146887572755;938.7746940734174;960.5725452173855;26779.866100669373;27422.177334679993;27565.17304480869;27577.310567235978;28003.29991750182;944.4994153098869;954.9570269337896;960.274992380762;960.5533426956499;990.9900900991042;13987.160770353812;14501.637459063608;14539.382911075896;14823.258837058103;14844.925775371054;390844;392710;396528;396714;398313;49272.507274927506;50059.24911126336;50060.249096263586;50067.24899126516;50083.499165008616;1069.3637285814928;1159.6810877008722;1170.5142365918218;1179.6669763167565;1190.5059400348932;27700.44599108047;28693.856530717214;28881.277968050967;29063.783438090733;29482.705172947997;41869.37195942002;42183.7890810544;42334.78832605817;42388.36417453802;42460.575394245665;302998;305861;306662;307577;307990;22293.554128917654;24253.878730606233;25030.74969250357;25177.874110630062;25240.242792716246;41673.37489937593;42010.369844452965;42582.787086064374;42641.147177056904;43016.139677206906;35464;36392.818035910714;36621;36961.26077478382;37112;35858.4621230687;36075.09812254609;36435.992040876015;36686.63313366832;36912;35288;36124.81937590295;36443.45334819927;36547;36555.81722091373;30394.240143995692;31834;32336.514952276204;32785.180370490925;32950.50574241436;24239.636405454286;24365.39086522851;24694.876525617256;25122;25210.74789252084 15:46:16 INFO - PROCESS | 396 | |2;jquery.html;376.363944933063;378.49470956273376;379.85185777546764;395.0893191194296;396.4133083037103;15963.920180399096;17578.208980595904;17895;18046.458606241802;18062.00658963758;16178.75731864023;16829.66340673186;16985.49043528693;17163.91418042908;17170.570735731613;5067.949320506794;5274.683518988853;5312.389075256337;5328.413874473805;5334.066538355792;3712.1462063725357;3918.3534716771696;5923.763049478016;6232.34560371159;6244.781432649858;5950.434708702688;6241.750329986795;6253.030780229072;6279.089532017854;6282.183316168892;6113.266408031021;6119.204503414549;6145.8156255312415;6156.38436156383;6159.753609855623;3412.0446275043028;5102.1071312520535;5476.534494567966;5477.370102438231;5524.696141712204;20256.594868102704;21079.789202108088;21247.15011399542;21261.46846328854;21270.255541056144;1931.6040211756556;2023.4233243525525;2052.8049835265624;2116.513201963557;2162.4053385319007;12711.427985740664;13284;13440.86559134406;13725.588232353046;14189.219592922385;1761.1986546121484;1800.5858652509996;1859.6838537448666;1867.3184287735014;1900.5723712164652;63250.25623078288;65296.99999999953;65878.3412165877;66308.3369166307;66482.66758666176;8849.469031858109;9104.952930412956;9920.40477571348;9978.750531236632;10195.949020254851;13467.528636497676;13692.726145477034;13720;13730.244836533886;13742.244176570384;6590.472762179014;6677.465802735769;6696.799096027127;6717.16035495563;6737.056812046318;5951.226340575698;6048.274207095089;6142.969285153546;6175.413335733098;6181.7527298908435;6131.233595800525;6203.937960620336;6257.4681152102585;6329;6544.443722283564;1668.9332426703038;1722.6554689062239;1812.8729710864488;1823.656601267365;1840.260953399025;796.653455746752;829.4774292195877;841.293313616565;885.8936927568604;945.9736186237872;16753;17092.48722538326;17490.737638935425;17619.735703964452;17874.5531361717;828.7679449754079;844.1937949258444;851.9616617252238;855.7561095087871;939.2157548447124;9585.233181345475;10386.11718003963;10407.271490995558;10437.791244175074;10484;378885;389802;390927;390962;391217;67157;67989.66005170041;69263;69441.65279173572;69524.30475695178;907.3013779389964;911.64901512918;936.6066252173968;939.5396255834728;942.8585712143097;15510;15583;15769.369225230863;15797;16233.837661623233;35060;35166;35599.64400355963;36431.635683642824;36638;44873.102537948405;45078;46261;47037;47795.761021194674;7719.536827790351;7789.493682910593;7862.488938218998;8101.270885620323;8116.553589552631;11794;11947.163698541019;12262.386880655753;12290.75418491643;12416;10123.848142278019;10223.233257505866;10258.640947566799;10470.685879423629;10508.632197873343;9465.574049167666;9765;10285.02292282232;10552.419616920835;10899.618513351994;9160.496172710566;9635.325527213028;9822.459764713009;9924.503774811375;10343.948280258852;6738.2587915328295;7110.217876033529;7266;7315.817104572216;7358.816029599303;8952.597133128895;9208.907910921072;9537.761555960878;9632.807343853225;10373.533191006574 15:46:16 INFO - PROCESS | 396 | |3;mootools.html;1241.081599616283;1368.2953279061278;1424.4587056918372;1467.9926600366996;1685.4353791479853;6938.340857618525;7910.485818421806;8211.343092552597;8220.91779082209;8387.958060209705;8096;8260.504369737804;8270.090290068089;8270.421070525066;8287.668493260262;2224.077008041661;2256.954860902781;2264.071730590458;2265.3090807303847;2265.490264690448;2207.75714671386;2229.2197730794255;2229.264342766883;2246.034205291724;2248.3592176229777;2209.160519002785;2223.0774228695154;2234.296196698043;2236.3514580771557;2241.5853067182625;2141.9036143373587;2165.9566808663817;2169.3383518026994;2172.837037222199;2173.902174402148;2107.3993911735083;2113.0702490904105;2113.4505028692497;2114.450242936832;2116.0266277512364;8055.556944368057;8080.959595201986;8152.5516096614665;8153.633086511121;8336.541490218096;4715.457722361938;4831.975840120812;4847.927281090787;4870.829520966749;4875.658703890729;2869.239651492356;3026.7124623160767;3026.9243268918453;3086.9382612347854;3095.4273459410083;948.9335746497748;962.0235461007084;969.1907257440046;979.6962941488162;995.7012896131204;11169.162312826571;11258.380789056599;11289.717757056058;11292.830607540893;11312.943435282854;4288.52826189119;4292.806823692941;4293.377460268243;4363.19280933022;4372.956270437255;8797.780055498664;8826.338024648177;8839.071897450804;8845.4250473719;8846.734597962071;4760.904781904412;4761.095391875532;4771.165046116916;4771.570558649669;4774.570288674036;3742.550893892696;3770.4155855842387;4331.025519258142;4381.518033016366;4395.428594282723;3513.771604845677;3570.91072723184;3580.606133325332;3637.1452708613456;3652.7077833773765;999.6801023672355;1069.395791377869;1070.8929107089384;1075.5536452372335;1078.778850335695;722.8156820010863;826.5908375354238;826.8222332198607;837.9790505237418;842.839860426517;5196.740162991835;5278.392984806719;5284.894302113936;5382;5387.299651045339;807.3094749639049;826.0082791812478;852.2244757270854;855.2730179347504;867.8047439326101;3433.776804507699;3551.627079156703;3595.9280814383565;3649.61679023704;3671.7051842598376;9900;10151;10243.436610986319;10289.2797504174;10376.325538839952;10232.846507302396;10240.897591023995;10257.230707696803;10260.486975651187;10268;7174.78475645721;7649.502782319131;7786.104597971306;7790.961045194737;7799.49303295284;5704.629199102211;5722.4277572242445;5742;5851.093080572518;5865.94134058671;9386;9446.527673616154;9538.570764315762;9541.904580954102;9548;9654.179394751243;9673.70978870635;9743.853842192231;9790.971947945363;9794;6185.474234690102;6433.453156481752;6439.06633538125;6504.60972341661;6529;7567.9243207567215;7820.687172513036;7883.211678832071;8045.396595255263;8052.315553178046;6982.7206911725;7118.537295075804;7146.178189508273;7182.0004455335675;7198.640067996684;6905.240423553506;6942.652867356511;6952.965235173791;6969.895451568332;7023.789286321418;6340.524460665561;6443.774467893789;6444.871102578016;6445.4199122079235;6445.613263204223;4458.509563948028;4509.639228861749;4540.273556230987;4613.884652883705;4628.375169352229;4704.364910737144;4740.976295118502;4814.20565606671;4836.081144582518;4847.927281090716 15:46:16 INFO - PROCESS | 396 | |4;prototype.html;306.7760534809589;315.08153731871596;315.64805242155006;316.73394348747047;317.6981867226135;4900.289458028584;4939.481354457784;4943.269855550556;4957.652964292496;5002.12462819007;4921.237208232721;4946.579540739032;4950.316892256632;4953.405591329046;4959.330490383806;3689.6679298863096;3742.5321834770652;3766.4538641896906;3813.637704418076;3889.3470275133095;3844.8462061517507;3871.477350557667;3883.864064757734;3885.6502914737666;3892.143728379752;3838.1747924196293;3845.3270677631303;3847.2882516734353;3848.787631895958;3849.788261645608;3658.670719635232;3737.1591391936868;3805.46723458716;3814.828332725034;3833.674137698299;3379.9155021124425;3395.609504906918;3401.115709915415;3410.5907291125222;3412.266362732;4761.166795810719;4774.379330686988;4779.068081724065;4787.712737235742;4792.808287668489;4233.682473814445;4391.934120988188;4407.889802754925;4410.015493028118;4424.340872172935;5069.518395752398;5085.745712714386;5099.872503187413;5120.308758317654;5152.690838549699;3721.2371463849845;3721.7160079772434;3743.4838890249493;3744.2885851688093;3751.9624803751885;5088.847334579968;5336.9733151334385;5357.732113394315;5363.570914326844;5369.892602147975;3802.4676545283683;3809.6380843819793;3827.483289755847;3830.3105441020325;3839.8321384857604;3893.4549163117185;3897.5322961244833;3901.1521589240015;3901.4784234148706;3902.824372903226;4348.847790327323;4373.169097871394;4387.42963414754;4397.208502469586;4402.3176407656865;4852.272159176152;5094.872628184251;5131.640785145004;5134.306868572695;5135.6148288878485;1346.9191848489122;1349.2713934475273;1354.823872896517;1355.1733442600007;1361.7140400515805;874.6501399440148;880.1286726141202;896.7535126174622;919.9632014719471;935.7847695030181;4510.939929116655;4529.932051019237;4539.364488971547;4541.909161816811;4551.975805443749;5246.737663116829;5249.553787928069;5253.922945796103;5257.237700533401;5266.657667251617;4353.17166789949;4531.342955271467;4533.569310915458;4551.613112885376;4557.248054071041;2780.3466185446405;2796.8321900686024;2801.8318900865606;2813.6342275504053;2814.6622405311496;4895.877603059881;4941.827036053721;4966;4989;4993.126202914548;5141.665791723526;5400.703831080591;5405.513443828709;5412.3505179377935;5424.918626220609;4944.703317800943;4962.206047032458;4968.403791544965;4974.27872958419;4984.77568509418;5173.1722924331925;5180.61145414103;5188;5188.818391356435;5249.7112658804135;4935.876603084952;5078.365204349457;5128.051310507568;5163.225516172604;5184.170532714747;4836.782344794422;4903.387076615423;4905.190643543918;4973.5523802857915;4989.426215985208;3835.2712984533964;3837.639851491257;3850.614938506127;3852.8651497197466;3871.6515513603913;5076.82231121909;5127.359080114986;5200.5059519345605;5226.8954620908125;5228.928069745769;4993.750312484289;5006.274090256965;5053.722045287397;5065.581637141606;5092.8472145835685;5034.270030845581;5048.3941926969;5061.190209566452;5063.392392912874;5063.898722025465;4761.666683332133;4999.400071991385;5004.899902002013;5013.092406404349;5031.1825377788555;4954.826581069645;5016.849494515171;5151.098557752453;5186.118359878754;5196.844094677166;5067.189249720027;5073.59411247092;5075;5078.923816142835;5109.412417572027 15:46:16 INFO - PROCESS | 396 | |5;yui.html;618.1716499890147;644.5699712085441;666.2038863558049;675.918889733232;701.9996504980402;11974.221675591081;12901.870981290183;12912;12912.806307905377;12920.095593308472;12303.876961230386;12494.500219991189;12554.183978041421;12563.93718031411;13025.73948521029;623.7785586116931;780.04055012335;790.4071946040469;793.8134538383475;795.1333046978792;764.3655765714471;793.0681449297082;799.0730752327302;800.0079900922843;800.9759707208793;834.2200042959821;834.7913021744564;837.1628371628371;837.2632083766277;837.8073043200068;649.95775274607;670.7954074007425;832.7460124661976;833.1460253240416;836.573347592726;498.2625713943384;498.4990084964587;590.4449817171844;606.8149214489579;610.0026456743257;12020.158588898781;12033.939830300793;12046.096542759327;12092.939535302356;12102.092343074304;12009.339486328248;12451.813222801666;12496.81254781179;12562.30907300098;12803.359832008362;9402.43585384879;9462.668806591737;10426.530806113667;10477.43505845734;10834.566617335297;4291.163223171483;4371.606555410029;4372.978135109304;4402.845900393503;4520.909581808378;58823.70588147075;59934.10098848521;60035.39964600342;60521.09218361728;60532.697336513476;10350.896491035144;10482.213833962483;10640.414777187329;10814.29707069038;10886.836697449544;17493.7375939361;18151.364702235358;18278.817211827976;18284.908575457037;18302.816971830376;7214.458915581353;7269.963650181821;7283.526570772989;7298.854022919512;7406.629668516553;3813.161104556993;3827.13889374894;3884.3008258513737;3888.3972984187494;3969.5236571611013;2949.3953739483354;3050.008747157183;3052.877884884624;3056.923576910595;3059.877604895824;523.0950455711641;523.8140460136673;551.6938099354896;554.7780887644974;556.6548739781362;469.16254485742786;530.2920600997711;548.1968915538755;548.4077196627633;559.3930585314979;7186.209516953131;7385.963070184722;7416.147143078507;7532.54804711719;7577.5453472791805;411.5020824802023;423.7796345900115;555.7395934794542;566.4279078131117;605.9484943779828;3498.737594680409;3658.6280144945645;3677.2645470905927;3718.1262403335195;3722.646348596879;87194.56402717945;95304;97929;97995;98165;61585;63557;66483;67113.66443167753;69170.3082969174;67092.66453667798;69675.30324696688;70281;71074.64462677758;71412.64293678603;7341.853162936818;7458.105027396748;7475.252474752481;7502.174760776419;7593.1647518774;41772.373414399415;43717.507798128856;45001.77499112614;45089.77455112835;45105.36182977128;58467;64325.03512447223;64422;64944.35055649572;65196.348036519026;11639.418029098342;11667.708307292385;11710;11786.292822430682;12342.321172335249;13409;13545.390457429636;14029.088109272865;14066.296685165906;14504.709905801614;11106.944465277622;11264.15518836107;11264.211505194886;11583.015443687382;11588.362640054878;11686.649400517997;12051.819222711842;12054.75890482203;12102.93948530287;12124.33316167584;10969.945150274198;11014.284071535325;11199.720006999563;11413.714657133305;11688.590899318484;9693.951530242304;10004.149647280063;10028;10160.441175735405;10193.184545236512;9569.751108489638;9920.355176913477;9946.55240514193;9954.950225248827;9997.900020999698 15:46:16 INFO - PROCESS | 396 | __end_tp_report 15:46:16 INFO - PROCESS | 396 | __start_cc_report 15:46:16 INFO - PROCESS | 396 | _x_x_mozilla_cycle_collect,979 15:46:16 INFO - PROCESS | 396 | __end_cc_report 15:46:16 INFO - PROCESS | 396 | __startTimestamp1467067576926__endTimestamp 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | ------- Summary: start ------- 15:46:16 INFO - PROCESS | 396 | Number of tests: 6 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | [#0] dojo.html Cycles:165 Average:4801.99 Median:4928.58 stddev:506.50 (10.3%) stddev-sans-first:478.61 15:46:16 INFO - PROCESS | 396 | Values: 2632.9 2639.2 2678.6 2693.8 2697.8 4659.4 4717.9 4725.0 4802.7 4854.1 4791.4 4812.4 4834.5 4856.5 4891.9 4414.0 4444.4 4470.2 4487.3 4590.2 4471.9 4533.4 4579.0 4616.3 4620.7 4334.5 4513.7 4537.3 4558.0 4564.3 4379.1 4411.2 4411.4 4421.8 4432.6 4366.7 4385.3 4390.8 4428.4 4439.2 4897.4 4908.3 4919.7 4924.4 4931.6 5045.9 5112.7 5175.5 5182.2 5223.0 5247.6 5268.1 5282.5 5283.0 5290.0 4855.7 4863.1 4900.3 4912.0 4914.6 5246.2 5246.6 5250.0 5287.5 5320.1 5039.2 5067.9 5092.0 5099.5 5099.9 5137.0 5138.4 5142.2 5145.3 5179.7 5032.3 5037.2 5059.0 5093.8 5102.1 5076.9 5077.1 5084.7 5086.0 5126.9 4396.2 4397.7 4400.7 4418.3 4473.9 3793.5 3807.4 3823.8 3833.7 3873.4 4499.5 4507.5 4529.5 4539.9 4545.6 5208.4 5208.4 5218.4 5218.6 5266.5 4429.4 4477.5 4486.8 4496.3 4531.3 4715.4 4736.2 4745.2 4753.2 4804.0 4879.8 4924.2 4928.6 4936.8 4957.1 5066.6 5165.3 5180.6 5269.6 5316.3 4847.8 4872.1 4872.9 4918.7 4955.0 5160.1 5161.8 5162.0 5174.9 5183.2 5074.8 5177.6 5213.3 5230.7 5259.9 5106.5 5116.7 5124.4 5127.3 5128.0 5091.3 5092.1 5093.0 5107.6 5110.7 4878.1 4961.1 5010.1 5025.1 5095.5 5124.5 5126.7 5127.6 5128.1 5146.5 4885.5 5034.5 5037.9 5043.9 5085.1 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | [#1] ext.html Cycles:180 Average:45667.59 Median:36551.41 stddev:84540.35 (231.3%) stddev-sans-first:84709.63 15:46:16 INFO - PROCESS | 396 | Values: 545.3 578.1 579.5 583.9 592.4 26121.5 28772.3 39030.4 39709.4 39844.6 41064.6 41506.0 41527.8 41589.2 41609.0 7575.2 7720.1 7723.6 7724.2 7726.4 7879.7 7977.6 7980.1 7981.4 7983.8 7935.6 8001.5 8002.0 8002.8 8007.1 7940.0 7964.1 7983.7 7985.8 7986.0 7625.7 7688.2 7690.9 7694.1 7701.5 39584.4 39744.6 39911.0 40149.2 40167.6 3222.8 3369.9 3524.6 3671.7 3769.0 29114.3 29405.0 29464.4 29931.6 30838.2 3433.4 3443.0 3447.5 3514.3 3555.3 239999.0 240267.0 240343.0 240888.0 241338.8 31394.2 32495.5 49789.3 49802.5 49981.8 34023.3 34064.8 34136.1 34210.1 34221.0 12285.8 12294.8 12332.4 12343.6 12359.8 10631.8 10711.2 10713.9 10714.2 10721.0 7886.0 7896.6 7916.8 7961.5 7997.6 3098.4 3118.9 3154.9 3159.7 3210.1 870.5 873.4 906.6 938.8 960.6 26779.9 27422.2 27565.2 27577.3 28003.3 944.5 955.0 960.3 960.6 991.0 13987.2 14501.6 14539.4 14823.3 14844.9 390844.0 392710.0 396528.0 396714.0 398313.0 49272.5 50059.2 50060.2 50067.2 50083.5 1069.4 1159.7 1170.5 1179.7 1190.5 27700.4 28693.9 28881.3 29063.8 29482.7 41869.4 42183.8 42334.8 42388.4 42460.6 302998.0 305861.0 306662.0 307577.0 307990.0 22293.6 24253.9 25030.7 25177.9 25240.2 41673.4 42010.4 42582.8 42641.1 43016.1 35464.0 36392.8 36621.0 36961.3 37112.0 35858.5 36075.1 36436.0 36686.6 36912.0 35288.0 36124.8 36443.5 36547.0 36555.8 30394.2 31834.0 32336.5 32785.2 32950.5 24239.6 24365.4 24694.9 25122.0 25210.7 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | [#2] jquery.html Cycles:180 Average:23962.67 Median:46649.00 stddev:63794.16 (136.8%) stddev-sans-first:63948.54 15:46:16 INFO - PROCESS | 396 | Values: 376.4 378.5 379.9 395.1 396.4 15963.9 17578.2 17895.0 18046.5 18062.0 16178.8 16829.7 16985.5 17163.9 17170.6 5067.9 5274.7 5312.4 5328.4 5334.1 3712.1 3918.4 5923.8 6232.3 6244.8 5950.4 6241.8 6253.0 6279.1 6282.2 6113.3 6119.2 6145.8 6156.4 6159.8 3412.0 5102.1 5476.5 5477.4 5524.7 20256.6 21079.8 21247.2 21261.5 21270.3 1931.6 2023.4 2052.8 2116.5 2162.4 12711.4 13284.0 13440.9 13725.6 14189.2 1761.2 1800.6 1859.7 1867.3 1900.6 63250.3 65297.0 65878.3 66308.3 66482.7 8849.5 9105.0 9920.4 9978.8 10195.9 13467.5 13692.7 13720.0 13730.2 13742.2 6590.5 6677.5 6696.8 6717.2 6737.1 5951.2 6048.3 6143.0 6175.4 6181.8 6131.2 6203.9 6257.5 6329.0 6544.4 1668.9 1722.7 1812.9 1823.7 1840.3 796.7 829.5 841.3 885.9 946.0 16753.0 17092.5 17490.7 17619.7 17874.6 828.8 844.2 852.0 855.8 939.2 9585.2 10386.1 10407.3 10437.8 10484.0 378885.0 389802.0 390927.0 390962.0 391217.0 67157.0 67989.7 69263.0 69441.7 69524.3 907.3 911.6 936.6 939.5 942.9 15510.0 15583.0 15769.4 15797.0 16233.8 35060.0 35166.0 35599.6 36431.6 36638.0 44873.1 45078.0 46261.0 47037.0 47795.8 7719.5 7789.5 7862.5 8101.3 8116.6 11794.0 11947.2 12262.4 12290.8 12416.0 10123.8 10223.2 10258.6 10470.7 10508.6 9465.6 9765.0 10285.0 10552.4 10899.6 9160.5 9635.3 9822.5 9924.5 10343.9 6738.3 7110.2 7266.0 7315.8 7358.8 8952.6 9208.9 9537.8 9632.8 10373.5 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | [#3] mootools.html Cycles:180 Average:5313.95 Median:4859.38 stddev:3051.92 (62.8%) stddev-sans-first:3045.13 15:46:16 INFO - PROCESS | 396 | Values: 1241.1 1368.3 1424.5 1468.0 1685.4 6938.3 7910.5 8211.3 8220.9 8388.0 8096.0 8260.5 8270.1 8270.4 8287.7 2224.1 2257.0 2264.1 2265.3 2265.5 2207.8 2229.2 2229.3 2246.0 2248.4 2209.2 2223.1 2234.3 2236.4 2241.6 2141.9 2166.0 2169.3 2172.8 2173.9 2107.4 2113.1 2113.5 2114.5 2116.0 8055.6 8081.0 8152.6 8153.6 8336.5 4715.5 4832.0 4847.9 4870.8 4875.7 2869.2 3026.7 3026.9 3086.9 3095.4 948.9 962.0 969.2 979.7 995.7 11169.2 11258.4 11289.7 11292.8 11312.9 4288.5 4292.8 4293.4 4363.2 4373.0 8797.8 8826.3 8839.1 8845.4 8846.7 4760.9 4761.1 4771.2 4771.6 4774.6 3742.6 3770.4 4331.0 4381.5 4395.4 3513.8 3570.9 3580.6 3637.1 3652.7 999.7 1069.4 1070.9 1075.6 1078.8 722.8 826.6 826.8 838.0 842.8 5196.7 5278.4 5284.9 5382.0 5387.3 807.3 826.0 852.2 855.3 867.8 3433.8 3551.6 3595.9 3649.6 3671.7 9900.0 10151.0 10243.4 10289.3 10376.3 10232.8 10240.9 10257.2 10260.5 10268.0 7174.8 7649.5 7786.1 7791.0 7799.5 5704.6 5722.4 5742.0 5851.1 5865.9 9386.0 9446.5 9538.6 9541.9 9548.0 9654.2 9673.7 9743.9 9791.0 9794.0 6185.5 6433.5 6439.1 6504.6 6529.0 7567.9 7820.7 7883.2 8045.4 8052.3 6982.7 7118.5 7146.2 7182.0 7198.6 6905.2 6942.7 6953.0 6969.9 7023.8 6340.5 6443.8 6444.9 6445.4 6445.6 4458.5 4509.6 4540.3 4613.9 4628.4 4704.4 4741.0 4814.2 4836.1 4847.9 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | [#4] prototype.html Cycles:180 Average:4262.84 Median:4904.29 stddev:1214.38 (24.8%) stddev-sans-first:1180.92 15:46:16 INFO - PROCESS | 396 | Values: 306.8 315.1 315.6 316.7 317.7 4900.3 4939.5 4943.3 4957.7 5002.1 4921.2 4946.6 4950.3 4953.4 4959.3 3689.7 3742.5 3766.5 3813.6 3889.3 3844.8 3871.5 3883.9 3885.7 3892.1 3838.2 3845.3 3847.3 3848.8 3849.8 3658.7 3737.2 3805.5 3814.8 3833.7 3379.9 3395.6 3401.1 3410.6 3412.3 4761.2 4774.4 4779.1 4787.7 4792.8 4233.7 4391.9 4407.9 4410.0 4424.3 5069.5 5085.7 5099.9 5120.3 5152.7 3721.2 3721.7 3743.5 3744.3 3752.0 5088.8 5337.0 5357.7 5363.6 5369.9 3802.5 3809.6 3827.5 3830.3 3839.8 3893.5 3897.5 3901.2 3901.5 3902.8 4348.8 4373.2 4387.4 4397.2 4402.3 4852.3 5094.9 5131.6 5134.3 5135.6 1346.9 1349.3 1354.8 1355.2 1361.7 874.7 880.1 896.8 920.0 935.8 4510.9 4529.9 4539.4 4541.9 4552.0 5246.7 5249.6 5253.9 5257.2 5266.7 4353.2 4531.3 4533.6 4551.6 4557.2 2780.3 2796.8 2801.8 2813.6 2814.7 4895.9 4941.8 4966.0 4989.0 4993.1 5141.7 5400.7 5405.5 5412.4 5424.9 4944.7 4962.2 4968.4 4974.3 4984.8 5173.2 5180.6 5188.0 5188.8 5249.7 4935.9 5078.4 5128.1 5163.2 5184.2 4836.8 4903.4 4905.2 4973.6 4989.4 3835.3 3837.6 3850.6 3852.9 3871.7 5076.8 5127.4 5200.5 5226.9 5228.9 4993.8 5006.3 5053.7 5065.6 5092.8 5034.3 5048.4 5061.2 5063.4 5063.9 4761.7 4999.4 5004.9 5013.1 5031.2 4954.8 5016.8 5151.1 5186.1 5196.8 5067.2 5073.6 5075.0 5078.9 5109.4 15:46:16 INFO - PROCESS | 396 | 15:46:16 INFO - PROCESS | 396 | [#5] yui.html Cycles:180 Average:16956.61 Median:498.38 stddev:23548.95 (4725.1%) stddev-sans-first:23583.05 15:46:16 INFO - PROCESS | 396 | Values: 618.2 644.6 666.2 675.9 702.0 11974.2 12901.9 12912.0 12912.8 12920.1 12303.9 12494.5 12554.2 12563.9 13025.7 623.8 780.0 790.4 793.8 795.1 764.4 793.1 799.1 800.0 801.0 834.2 834.8 837.2 837.3 837.8 650.0 670.8 832.7 833.1 836.6 498.3 498.5 590.4 606.8 610.0 12020.2 12033.9 12046.1 12092.9 12102.1 12009.3 12451.8 12496.8 12562.3 12803.4 9402.4 9462.7 10426.5 10477.4 10834.6 4291.2 4371.6 4373.0 4402.8 4520.9 58823.7 59934.1 60035.4 60521.1 60532.7 10350.9 10482.2 10640.4 10814.3 10886.8 17493.7 18151.4 18278.8 18284.9 18302.8 7214.5 7270.0 7283.5 7298.9 7406.6 3813.2 3827.1 3884.3 3888.4 3969.5 2949.4 3050.0 3052.9 3056.9 3059.9 523.1 523.8 551.7 554.8 556.7 469.2 530.3 548.2 548.4 559.4 7186.2 7386.0 7416.1 7532.5 7577.5 411.5 423.8 555.7 566.4 605.9 3498.7 3658.6 3677.3 3718.1 3722.6 87194.6 95304.0 97929.0 97995.0 98165.0 61585.0 63557.0 66483.0 67113.7 69170.3 67092.7 69675.3 70281.0 71074.6 71412.6 7341.9 7458.1 7475.3 7502.2 7593.2 41772.4 43717.5 45001.8 45089.8 45105.4 58467.0 64325.0 64422.0 64944.4 65196.3 11639.4 11667.7 11710.0 11786.3 12342.3 13409.0 13545.4 14029.1 14066.3 14504.7 11106.9 11264.2 11264.2 11583.0 11588.4 11686.6 12051.8 12054.8 12102.9 12124.3 10969.9 11014.3 11199.7 11413.7 11688.6 9694.0 10004.1 10028.0 10160.4 10193.2 9569.8 9920.4 9946.6 9955.0 9997.9 15:46:16 INFO - PROCESS | 396 | -------- Summary: end -------- 15:46:16 INFO - PROCESS | 396 | 15:46:17 INFO - TEST-INFO | 396: exit 0 15:46:17 INFO - TEST-OK | dromaeo_css | took 1120555ms 15:46:17 INFO - TEST-START | kraken 15:46:17 INFO - operating with platform_type : linux_ 15:46:17 INFO - Initialising browser for kraken test... 15:46:17 INFO - TEST-INFO | started process 582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm8QzjH/profile http://localhost:53148/getInfo.html) 15:46:22 INFO - PROCESS | 582 | __metrics Screen width/height:1600/1200 15:46:22 INFO - PROCESS | 582 | colorDepth:24 15:46:22 INFO - PROCESS | 582 | Browser inner width/height: 1024/697 15:46:22 INFO - PROCESS | 582 | __metrics 15:46:23 INFO - PROCESS | 582 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:46:24 INFO - TEST-INFO | 582: exit 0 15:46:24 INFO - Browser initialized. 15:46:24 INFO - Running cycle 1/1 for kraken test... 15:46:24 INFO - TEST-INFO | started process 666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm8QzjH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:36 INFO - PROCESS | 666 | RSS: Main: 176107520 15:46:36 INFO - PROCESS | 666 | 15:46:38 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53148/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:39 INFO - PROCESS | 666 | RSS: Main: 234020864 15:46:39 INFO - PROCESS | 666 | 15:46:42 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53148/tests/kraken/driver.html?testName=audio-dft) 15:46:43 INFO - PROCESS | 666 | RSS: Main: 222142464 15:46:43 INFO - PROCESS | 666 | 15:46:46 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53148/tests/kraken/driver.html?testName=audio-fft) 15:46:47 INFO - PROCESS | 666 | RSS: Main: 288280576 15:46:47 INFO - PROCESS | 666 | 15:46:49 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53148/tests/kraken/driver.html?testName=audio-oscillator) 15:46:49 INFO - PROCESS | 666 | RSS: Main: 198651904 15:46:49 INFO - PROCESS | 666 | 15:46:52 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:52 INFO - PROCESS | 666 | RSS: Main: 203145216 15:46:52 INFO - PROCESS | 666 | 15:46:55 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53148/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:56 INFO - PROCESS | 666 | RSS: Main: 238841856 15:46:56 INFO - PROCESS | 666 | 15:47:00 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53148/tests/kraken/driver.html?testName=imaging-desaturate) 15:47:00 INFO - PROCESS | 666 | RSS: Main: 234422272 15:47:00 INFO - PROCESS | 666 | 15:47:03 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53148/tests/kraken/driver.html?testName=json-parse-financial) 15:47:04 INFO - PROCESS | 666 | RSS: Main: 236552192 15:47:04 INFO - PROCESS | 666 | 15:47:05 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:06 INFO - PROCESS | 666 | RSS: Main: 223989760 15:47:06 INFO - PROCESS | 666 | 15:47:08 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:09 INFO - PROCESS | 666 | RSS: Main: 228343808 15:47:09 INFO - PROCESS | 666 | 15:47:11 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:11 INFO - PROCESS | 666 | RSS: Main: 235192320 15:47:11 INFO - PROCESS | 666 | 15:47:14 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:15 INFO - PROCESS | 666 | RSS: Main: 238706688 15:47:15 INFO - PROCESS | 666 | 15:47:18 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:18 INFO - PROCESS | 666 | RSS: Main: 238977024 15:47:18 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | Cycle 1(1): loaded http://localhost:53148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53148/tests/kraken/driver.html?testName=ai-astar) 15:47:20 INFO - PROCESS | 666 | RSS: Main: 281427968 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | __start_tp_report 15:47:20 INFO - PROCESS | 666 | _x_x_mozilla_page_load 15:47:20 INFO - PROCESS | 666 | _x_x_mozilla_page_load_details 15:47:20 INFO - PROCESS | 666 | |i|pagename|runs| 15:47:20 INFO - PROCESS | 666 | |0;ai-astar;105;115;114;115;114;115;114;114;114;115 15:47:20 INFO - PROCESS | 666 | |1;audio-beat-detection;164;131;135;189;130;140;172;132;191;132 15:47:20 INFO - PROCESS | 666 | |2;audio-dft;161;163;162;163;160;162;162;161;161;161 15:47:20 INFO - PROCESS | 666 | |3;audio-fft;76;75;78;131;77;77;76;76;99;76 15:47:20 INFO - PROCESS | 666 | |4;audio-oscillator;86;86;122;85;85;87;117;86;86;125 15:47:20 INFO - PROCESS | 666 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;116;117 15:47:20 INFO - PROCESS | 666 | |6;imaging-darkroom;147;146;146;147;146;146;147;147;146;147 15:47:20 INFO - PROCESS | 666 | |7;imaging-desaturate;96;94;94;95;95;97;95;94;95;95 15:47:20 INFO - PROCESS | 666 | |8;json-parse-financial;63;64;63;64;64;66;64;63;63;65 15:47:20 INFO - PROCESS | 666 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;65;65;66 15:47:20 INFO - PROCESS | 666 | |10;stanford-crypto-aes;83;82;82;81;84;82;83;84;91;84 15:47:20 INFO - PROCESS | 666 | |11;stanford-crypto-ccm;135;134;131;130;130;126;140;131;133;141 15:47:20 INFO - PROCESS | 666 | |12;stanford-crypto-pbkdf2;170;168;165;167;167;171;171;164;164;164 15:47:20 INFO - PROCESS | 666 | |13;stanford-crypto-sha256-iterative;67;68;67;68;68;66;66;66;65;67 15:47:20 INFO - PROCESS | 666 | __end_tp_report 15:47:20 INFO - PROCESS | 666 | __start_cc_report 15:47:20 INFO - PROCESS | 666 | _x_x_mozilla_cycle_collect,1891 15:47:20 INFO - PROCESS | 666 | __end_cc_report 15:47:20 INFO - PROCESS | 666 | __startTimestamp1467067640761__endTimestamp 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | ------- Summary: start ------- 15:47:20 INFO - PROCESS | 666 | Number of tests: 14 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:3.03 (2.6%) stddev-sans-first:0.53 15:47:20 INFO - PROCESS | 666 | Values: 105.0 115.0 114.0 115.0 114.0 115.0 114.0 114.0 114.0 115.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:152.00 stddev:24.92 (16.4%) stddev-sans-first:26.03 15:47:20 INFO - PROCESS | 666 | Values: 164.0 131.0 135.0 189.0 130.0 140.0 172.0 132.0 191.0 132.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 15:47:20 INFO - PROCESS | 666 | Values: 161.0 163.0 162.0 163.0 160.0 162.0 162.0 161.0 161.0 161.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#3] audio-fft Cycles:10 Average:84.10 Median:76.50 stddev:17.97 (23.5%) stddev-sans-first:18.81 15:47:20 INFO - PROCESS | 666 | Values: 76.0 75.0 78.0 131.0 77.0 77.0 76.0 76.0 99.0 76.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:86.00 stddev:17.25 (20.1%) stddev-sans-first:17.87 15:47:20 INFO - PROCESS | 666 | Values: 86.0 86.0 122.0 85.0 85.0 87.0 117.0 86.0 86.0 125.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:47:20 INFO - PROCESS | 666 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:47:20 INFO - PROCESS | 666 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 15:47:20 INFO - PROCESS | 666 | Values: 96.0 94.0 94.0 95.0 95.0 97.0 95.0 94.0 95.0 95.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 15:47:20 INFO - PROCESS | 666 | Values: 63.0 64.0 63.0 64.0 64.0 66.0 64.0 63.0 63.0 65.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 15:47:20 INFO - PROCESS | 666 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.80 (3.3%) stddev-sans-first:2.96 15:47:20 INFO - PROCESS | 666 | Values: 83.0 82.0 82.0 81.0 84.0 82.0 83.0 84.0 91.0 84.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:133.50 stddev:4.63 (3.5%) stddev-sans-first:4.86 15:47:20 INFO - PROCESS | 666 | Values: 135.0 134.0 131.0 130.0 130.0 126.0 140.0 131.0 133.0 141.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.50 stddev:2.85 (1.7%) stddev-sans-first:2.82 15:47:20 INFO - PROCESS | 666 | Values: 170.0 168.0 165.0 167.0 167.0 171.0 171.0 164.0 164.0 164.0 15:47:20 INFO - PROCESS | 666 | 15:47:20 INFO - PROCESS | 666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 15:47:20 INFO - PROCESS | 666 | Values: 67.0 68.0 67.0 68.0 68.0 66.0 66.0 66.0 65.0 67.0 15:47:20 INFO - PROCESS | 666 | -------- Summary: end -------- 15:47:20 INFO - PROCESS | 666 | 15:47:21 INFO - TEST-INFO | 666: exit 0 15:47:21 INFO - TEST-OK | kraken | took 64222ms 15:47:21 INFO - SUITE-END | took 1184s 15:47:21 INFO - Completed test suite (00:19:44) 15:47:21 INFO - javascript benchmark 15:47:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.947341053179, 2639.234621959632, 2678.59821026846, 2693.838369697818, 2697.8111532192743, 4659.440867095945, 4717.882052948678, 4725.0, 4802.663813533054, 4854.05345957538, 4791.377120974268, 4812.374391329131, 4834.516548345164, 4856.490068542805, 4891.877703057426, 4414.02891363901, 4444.355568442574, 4470.195364834345, 4487.282034874421, 4590.150822097922, 4471.8658440246845, 4533.410656614636, 4578.97710511447, 4616.28447590624, 4620.745858977772, 4334.544872788343, 4513.684042117053, 4537.2740361542155, 4557.95442045582, 4564.269716845305, 4379.08039311745, 4411.1618792429335, 4411.448568928884, 4421.8452354167775, 4432.578905004052, 4366.737995720267, 4385.320275357325, 4390.846320378803, 4428.424304840382, 4439.156560253541, 4897.363342765418, 4908.263760435928, 4919.72941488218, 4924.359833221694, 4931.556159945622, 5045.949540504585, 5112.693238405707, 5175.482451754832, 5182.248573956793, 5222.973885130588, 5247.632665713401, 5268.130758424855, 5282.471752824726, 5283.049051170788, 5290.0, 4855.732934688555, 4863.051704917578, 4900.338454308694, 4912.0, 4914.631402644816, 5246.213068039825, 5246.554042906396, 5250.0, 5287.471252874681, 5320.14877619579, 5039.193729003342, 5067.923981140286, 5092.0, 5099.490050994871, 5099.9490005100215, 5136.9743151284, 5138.3577052868395, 5142.2029585413575, 5145.253938179018, 5179.689218646893, 5032.270320803536, 5037.219231019198, 5059.038782631288, 5093.796248150106, 5102.056119617882, 5076.923846142311, 5077.111505486525, 5084.745762711924, 5085.9745701271995, 5126.871828204325, 4396.230659634552, 4397.73613583186, 4400.669949753781, 4418.337249412614, 4473.888152796206, 3793.525809273841, 3807.3527500325013, 3823.7896915669903, 3833.6933045356864, 3873.4189871519498, 4499.460064792246, 4507.549245075466, 4529.456465224194, 4539.931901021488, 4545.5908968193025, 5208.374995000624, 5208.427073021964, 5218.373795144607, 5218.634695571273, 5266.473352664703, 4429.357743127229, 4477.485089214717, 4486.842960496432, 4496.325551167286, 4531.342955271533, 4715.41057367829, 4736.19484687597, 4745.193317136095, 4753.168195565762, 4803.991161856049, 4879.756012199305, 4924.187509060965, 4928.581070609039, 4936.777844996912, 4957.082939656175, 5066.569341606005, 5165.251038599457, 5180.559652429586, 5269.552088072557, 5316.255724198538, 4847.830325938575, 4872.123017856678, 4872.853814385574, 4918.655694101379, 4954.9752251238515, 5160.071187186342, 5161.81933632321, 5161.993411284763, 5174.9482505174465, 5183.248428977852, 5074.847754567369, 5177.585793136464, 5213.322268105122, 5230.712310822942, 5259.868503287448, 5106.46382129871, 5116.74416279192, 5124.385073791169, 5127.333446651912, 5128.025675121864, 5091.312672789126, 5092.057969275547, 5092.9745351273, 5107.6169287302855, 5110.693358398508, 4878.0975519529, 4961.1070007397575, 5010.123228435083, 5025.145725226647, 5095.541401273903, 5124.5131712487255, 5126.6923984561045, 5127.615428842777, 5128.051310507568, 5146.511081447256, 4885.5358740919555, 5034.493392289525, 5037.874053148701, 5043.899122017612, 5085.110105731408], "value": 4768.939442843403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2676855147212, 578.0664227272955, 579.4639958038814, 583.9357670656227, 592.4164697772693, 26121.47757044858, 28772.280692982687, 39030.414543781866, 39709.4334151572, 39844.60155398445, 41064.58935410645, 41506.0, 41527.79236103823, 41589.16821663573, 41609.0, 7575.166731659513, 7720.112187098472, 7723.61381930904, 7724.227577242259, 7726.42051846111, 7879.724209652634, 7977.641006154708, 7980.122186559473, 7981.401394895377, 7983.800404989864, 7935.563544005077, 8001.479903806263, 8002.039755229381, 8002.799930001767, 8007.119216886138, 7940.0, 7964.123946365895, 7983.680652773882, 7985.840283194332, 7985.96007019967, 7625.694972201105, 7688.1927397623, 7690.884636730453, 7694.115176754633, 7701.499402538817, 39584.40623390651, 39744.60255397467, 39911.0, 40149.197016059516, 40167.59832401697, 3222.7905186162825, 3369.8652053917813, 3524.6475352464804, 3671.6695497405362, 3768.9811550942068, 29114.272143196376, 29405.0, 29464.41071178586, 29931.551026734618, 30838.229044274074, 3433.4163192257374, 3442.9655703443145, 3447.517347571342, 3514.279572687593, 3555.306715190539, 239999.0, 240267.0, 240343.0, 240888.0, 241338.7933060341, 31394.21514462157, 32495.51256731151, 49789.253161202614, 49802.50197497979, 49981.75009125004, 34023.31953360919, 34064.82967585196, 34136.146596334795, 34210.14474638154, 34221.0, 12285.75428491443, 12294.75410491785, 12332.445039973223, 12343.629691109101, 12359.752804943852, 10631.787364252827, 10711.196660250356, 10713.892861071445, 10714.19643526723, 10721.035106840422, 7886.0, 7896.644650990719, 7916.802079947932, 7961.482503637245, 7997.640106195236, 3098.4422803895513, 3118.875244990175, 3154.8738050477723, 3159.699828516287, 3210.0530343548708, 870.5168631409501, 873.4409977614332, 906.6146887572755, 938.7746940734174, 960.5725452173855, 26779.866100669373, 27422.177334679993, 27565.17304480869, 27577.310567235978, 28003.29991750182, 944.4994153098869, 954.9570269337896, 960.274992380762, 960.5533426956499, 990.9900900991042, 13987.160770353812, 14501.637459063608, 14539.382911075896, 14823.258837058103, 14844.925775371054, 390844.0, 392710.0, 396528.0, 396714.0, 398313.0, 49272.507274927506, 50059.24911126336, 50060.249096263586, 50067.24899126516, 50083.499165008616, 1069.3637285814928, 1159.6810877008722, 1170.5142365918218, 1179.6669763167565, 1190.5059400348932, 27700.44599108047, 28693.856530717214, 28881.277968050967, 29063.783438090733, 29482.705172947997, 41869.37195942002, 42183.7890810544, 42334.78832605817, 42388.36417453802, 42460.575394245665, 302998.0, 305861.0, 306662.0, 307577.0, 307990.0, 22293.554128917654, 24253.878730606233, 25030.74969250357, 25177.874110630062, 25240.242792716246, 41673.37489937593, 42010.369844452965, 42582.787086064374, 42641.147177056904, 43016.139677206906, 35464.0, 36392.818035910714, 36621.0, 36961.26077478382, 37112.0, 35858.4621230687, 36075.09812254609, 36435.992040876015, 36686.63313366832, 36912.0, 35288.0, 36124.81937590295, 36443.45334819927, 36547.0, 36555.81722091373, 30394.240143995692, 31834.0, 32336.514952276204, 32785.180370490925, 32950.50574241436, 24239.636405454286, 24365.39086522851, 24694.876525617256, 25122.0, 25210.74789252084], "value": 16351.209139132896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.363944933063, 378.49470956273376, 379.85185777546764, 395.0893191194296, 396.4133083037103, 15963.920180399096, 17578.208980595904, 17895.0, 18046.458606241802, 18062.00658963758, 16178.75731864023, 16829.66340673186, 16985.49043528693, 17163.91418042908, 17170.570735731613, 5067.949320506794, 5274.683518988853, 5312.389075256337, 5328.413874473805, 5334.066538355792, 3712.1462063725357, 3918.3534716771696, 5923.763049478016, 6232.34560371159, 6244.781432649858, 5950.434708702688, 6241.750329986795, 6253.030780229072, 6279.089532017854, 6282.183316168892, 6113.266408031021, 6119.204503414549, 6145.8156255312415, 6156.38436156383, 6159.753609855623, 3412.0446275043028, 5102.1071312520535, 5476.534494567966, 5477.370102438231, 5524.696141712204, 20256.594868102704, 21079.789202108088, 21247.15011399542, 21261.46846328854, 21270.255541056144, 1931.6040211756556, 2023.4233243525525, 2052.8049835265624, 2116.513201963557, 2162.4053385319007, 12711.427985740664, 13284.0, 13440.86559134406, 13725.588232353046, 14189.219592922385, 1761.1986546121484, 1800.5858652509996, 1859.6838537448666, 1867.3184287735014, 1900.5723712164652, 63250.25623078288, 65296.99999999953, 65878.3412165877, 66308.3369166307, 66482.66758666176, 8849.469031858109, 9104.952930412956, 9920.40477571348, 9978.750531236632, 10195.949020254851, 13467.528636497676, 13692.726145477034, 13720.0, 13730.244836533886, 13742.244176570384, 6590.472762179014, 6677.465802735769, 6696.799096027127, 6717.16035495563, 6737.056812046318, 5951.226340575698, 6048.274207095089, 6142.969285153546, 6175.413335733098, 6181.7527298908435, 6131.233595800525, 6203.937960620336, 6257.4681152102585, 6329.0, 6544.443722283564, 1668.9332426703038, 1722.6554689062239, 1812.8729710864488, 1823.656601267365, 1840.260953399025, 796.653455746752, 829.4774292195877, 841.293313616565, 885.8936927568604, 945.9736186237872, 16753.0, 17092.48722538326, 17490.737638935425, 17619.735703964452, 17874.5531361717, 828.7679449754079, 844.1937949258444, 851.9616617252238, 855.7561095087871, 939.2157548447124, 9585.233181345475, 10386.11718003963, 10407.271490995558, 10437.791244175074, 10484.0, 378885.0, 389802.0, 390927.0, 390962.0, 391217.0, 67157.0, 67989.66005170041, 69263.0, 69441.65279173572, 69524.30475695178, 907.3013779389964, 911.64901512918, 936.6066252173968, 939.5396255834728, 942.8585712143097, 15510.0, 15583.0, 15769.369225230863, 15797.0, 16233.837661623233, 35060.0, 35166.0, 35599.64400355963, 36431.635683642824, 36638.0, 44873.102537948405, 45078.0, 46261.0, 47037.0, 47795.761021194674, 7719.536827790351, 7789.493682910593, 7862.488938218998, 8101.270885620323, 8116.553589552631, 11794.0, 11947.163698541019, 12262.386880655753, 12290.75418491643, 12416.0, 10123.848142278019, 10223.233257505866, 10258.640947566799, 10470.685879423629, 10508.632197873343, 9465.574049167666, 9765.0, 10285.02292282232, 10552.419616920835, 10899.618513351994, 9160.496172710566, 9635.325527213028, 9822.459764713009, 9924.503774811375, 10343.948280258852, 6738.2587915328295, 7110.217876033529, 7266.0, 7315.817104572216, 7358.816029599303, 8952.597133128895, 9208.907910921072, 9537.761555960878, 9632.807343853225, 10373.533191006574], "value": 8338.417203254035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.081599616283, 1368.2953279061278, 1424.4587056918372, 1467.9926600366996, 1685.4353791479853, 6938.340857618525, 7910.485818421806, 8211.343092552597, 8220.91779082209, 8387.958060209705, 8096.0, 8260.504369737804, 8270.090290068089, 8270.421070525066, 8287.668493260262, 2224.077008041661, 2256.954860902781, 2264.071730590458, 2265.3090807303847, 2265.490264690448, 2207.75714671386, 2229.2197730794255, 2229.264342766883, 2246.034205291724, 2248.3592176229777, 2209.160519002785, 2223.0774228695154, 2234.296196698043, 2236.3514580771557, 2241.5853067182625, 2141.9036143373587, 2165.9566808663817, 2169.3383518026994, 2172.837037222199, 2173.902174402148, 2107.3993911735083, 2113.0702490904105, 2113.4505028692497, 2114.450242936832, 2116.0266277512364, 8055.556944368057, 8080.959595201986, 8152.5516096614665, 8153.633086511121, 8336.541490218096, 4715.457722361938, 4831.975840120812, 4847.927281090787, 4870.829520966749, 4875.658703890729, 2869.239651492356, 3026.7124623160767, 3026.9243268918453, 3086.9382612347854, 3095.4273459410083, 948.9335746497748, 962.0235461007084, 969.1907257440046, 979.6962941488162, 995.7012896131204, 11169.162312826571, 11258.380789056599, 11289.717757056058, 11292.830607540893, 11312.943435282854, 4288.52826189119, 4292.806823692941, 4293.377460268243, 4363.19280933022, 4372.956270437255, 8797.780055498664, 8826.338024648177, 8839.071897450804, 8845.4250473719, 8846.734597962071, 4760.904781904412, 4761.095391875532, 4771.165046116916, 4771.570558649669, 4774.570288674036, 3742.550893892696, 3770.4155855842387, 4331.025519258142, 4381.518033016366, 4395.428594282723, 3513.771604845677, 3570.91072723184, 3580.606133325332, 3637.1452708613456, 3652.7077833773765, 999.6801023672355, 1069.395791377869, 1070.8929107089384, 1075.5536452372335, 1078.778850335695, 722.8156820010863, 826.5908375354238, 826.8222332198607, 837.9790505237418, 842.839860426517, 5196.740162991835, 5278.392984806719, 5284.894302113936, 5382.0, 5387.299651045339, 807.3094749639049, 826.0082791812478, 852.2244757270854, 855.2730179347504, 867.8047439326101, 3433.776804507699, 3551.627079156703, 3595.9280814383565, 3649.61679023704, 3671.7051842598376, 9900.0, 10151.0, 10243.436610986319, 10289.2797504174, 10376.325538839952, 10232.846507302396, 10240.897591023995, 10257.230707696803, 10260.486975651187, 10268.0, 7174.78475645721, 7649.502782319131, 7786.104597971306, 7790.961045194737, 7799.49303295284, 5704.629199102211, 5722.4277572242445, 5742.0, 5851.093080572518, 5865.94134058671, 9386.0, 9446.527673616154, 9538.570764315762, 9541.904580954102, 9548.0, 9654.179394751243, 9673.70978870635, 9743.853842192231, 9790.971947945363, 9794.0, 6185.474234690102, 6433.453156481752, 6439.06633538125, 6504.60972341661, 6529.0, 7567.9243207567215, 7820.687172513036, 7883.211678832071, 8045.396595255263, 8052.315553178046, 6982.7206911725, 7118.537295075804, 7146.178189508273, 7182.0004455335675, 7198.640067996684, 6905.240423553506, 6942.652867356511, 6952.965235173791, 6969.895451568332, 7023.789286321418, 6340.524460665561, 6443.774467893789, 6444.871102578016, 6445.4199122079235, 6445.613263204223, 4458.509563948028, 4509.639228861749, 4540.273556230987, 4613.884652883705, 4628.375169352229, 4704.364910737144, 4740.976295118502, 4814.20565606671, 4836.081144582518, 4847.927281090716], "value": 4228.293031703941, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.7760534809589, 315.08153731871596, 315.64805242155006, 316.73394348747047, 317.6981867226135, 4900.289458028584, 4939.481354457784, 4943.269855550556, 4957.652964292496, 5002.12462819007, 4921.237208232721, 4946.579540739032, 4950.316892256632, 4953.405591329046, 4959.330490383806, 3689.6679298863096, 3742.5321834770652, 3766.4538641896906, 3813.637704418076, 3889.3470275133095, 3844.8462061517507, 3871.477350557667, 3883.864064757734, 3885.6502914737666, 3892.143728379752, 3838.1747924196293, 3845.3270677631303, 3847.2882516734353, 3848.787631895958, 3849.788261645608, 3658.670719635232, 3737.1591391936868, 3805.46723458716, 3814.828332725034, 3833.674137698299, 3379.9155021124425, 3395.609504906918, 3401.115709915415, 3410.5907291125222, 3412.266362732, 4761.166795810719, 4774.379330686988, 4779.068081724065, 4787.712737235742, 4792.808287668489, 4233.682473814445, 4391.934120988188, 4407.889802754925, 4410.015493028118, 4424.340872172935, 5069.518395752398, 5085.745712714386, 5099.872503187413, 5120.308758317654, 5152.690838549699, 3721.2371463849845, 3721.7160079772434, 3743.4838890249493, 3744.2885851688093, 3751.9624803751885, 5088.847334579968, 5336.9733151334385, 5357.732113394315, 5363.570914326844, 5369.892602147975, 3802.4676545283683, 3809.6380843819793, 3827.483289755847, 3830.3105441020325, 3839.8321384857604, 3893.4549163117185, 3897.5322961244833, 3901.1521589240015, 3901.4784234148706, 3902.824372903226, 4348.847790327323, 4373.169097871394, 4387.42963414754, 4397.208502469586, 4402.3176407656865, 4852.272159176152, 5094.872628184251, 5131.640785145004, 5134.306868572695, 5135.6148288878485, 1346.9191848489122, 1349.2713934475273, 1354.823872896517, 1355.1733442600007, 1361.7140400515805, 874.6501399440148, 880.1286726141202, 896.7535126174622, 919.9632014719471, 935.7847695030181, 4510.939929116655, 4529.932051019237, 4539.364488971547, 4541.909161816811, 4551.975805443749, 5246.737663116829, 5249.553787928069, 5253.922945796103, 5257.237700533401, 5266.657667251617, 4353.17166789949, 4531.342955271467, 4533.569310915458, 4551.613112885376, 4557.248054071041, 2780.3466185446405, 2796.8321900686024, 2801.8318900865606, 2813.6342275504053, 2814.6622405311496, 4895.877603059881, 4941.827036053721, 4966.0, 4989.0, 4993.126202914548, 5141.665791723526, 5400.703831080591, 5405.513443828709, 5412.3505179377935, 5424.918626220609, 4944.703317800943, 4962.206047032458, 4968.403791544965, 4974.27872958419, 4984.77568509418, 5173.1722924331925, 5180.61145414103, 5188.0, 5188.818391356435, 5249.7112658804135, 4935.876603084952, 5078.365204349457, 5128.051310507568, 5163.225516172604, 5184.170532714747, 4836.782344794422, 4903.387076615423, 4905.190643543918, 4973.5523802857915, 4989.426215985208, 3835.2712984533964, 3837.639851491257, 3850.614938506127, 3852.8651497197466, 3871.6515513603913, 5076.82231121909, 5127.359080114986, 5200.5059519345605, 5226.8954620908125, 5228.928069745769, 4993.750312484289, 5006.274090256965, 5053.722045287397, 5065.581637141606, 5092.8472145835685, 5034.270030845581, 5048.3941926969, 5061.190209566452, 5063.392392912874, 5063.898722025465, 4761.666683332133, 4999.400071991385, 5004.899902002013, 5013.092406404349, 5031.1825377788555, 4954.826581069645, 5016.849494515171, 5151.098557752453, 5186.118359878754, 5196.844094677166, 5067.189249720027, 5073.59411247092, 5075.0, 5078.923816142835, 5109.412417572027], "value": 3882.0324518746424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.1716499890147, 644.5699712085441, 666.2038863558049, 675.918889733232, 701.9996504980402, 11974.221675591081, 12901.870981290183, 12912.0, 12912.806307905377, 12920.095593308472, 12303.876961230386, 12494.500219991189, 12554.183978041421, 12563.93718031411, 13025.73948521029, 623.7785586116931, 780.04055012335, 790.4071946040469, 793.8134538383475, 795.1333046978792, 764.3655765714471, 793.0681449297082, 799.0730752327302, 800.0079900922843, 800.9759707208793, 834.2200042959821, 834.7913021744564, 837.1628371628371, 837.2632083766277, 837.8073043200068, 649.95775274607, 670.7954074007425, 832.7460124661976, 833.1460253240416, 836.573347592726, 498.2625713943384, 498.4990084964587, 590.4449817171844, 606.8149214489579, 610.0026456743257, 12020.158588898781, 12033.939830300793, 12046.096542759327, 12092.939535302356, 12102.092343074304, 12009.339486328248, 12451.813222801666, 12496.81254781179, 12562.30907300098, 12803.359832008362, 9402.43585384879, 9462.668806591737, 10426.530806113667, 10477.43505845734, 10834.566617335297, 4291.163223171483, 4371.606555410029, 4372.978135109304, 4402.845900393503, 4520.909581808378, 58823.70588147075, 59934.10098848521, 60035.39964600342, 60521.09218361728, 60532.697336513476, 10350.896491035144, 10482.213833962483, 10640.414777187329, 10814.29707069038, 10886.836697449544, 17493.7375939361, 18151.364702235358, 18278.817211827976, 18284.908575457037, 18302.816971830376, 7214.458915581353, 7269.963650181821, 7283.526570772989, 7298.854022919512, 7406.629668516553, 3813.161104556993, 3827.13889374894, 3884.3008258513737, 3888.3972984187494, 3969.5236571611013, 2949.3953739483354, 3050.008747157183, 3052.877884884624, 3056.923576910595, 3059.877604895824, 523.0950455711641, 523.8140460136673, 551.6938099354896, 554.7780887644974, 556.6548739781362, 469.16254485742786, 530.2920600997711, 548.1968915538755, 548.4077196627633, 559.3930585314979, 7186.209516953131, 7385.963070184722, 7416.147143078507, 7532.54804711719, 7577.5453472791805, 411.5020824802023, 423.7796345900115, 555.7395934794542, 566.4279078131117, 605.9484943779828, 3498.737594680409, 3658.6280144945645, 3677.2645470905927, 3718.1262403335195, 3722.646348596879, 87194.56402717945, 95304.0, 97929.0, 97995.0, 98165.0, 61585.0, 63557.0, 66483.0, 67113.66443167753, 69170.3082969174, 67092.66453667798, 69675.30324696688, 70281.0, 71074.64462677758, 71412.64293678603, 7341.853162936818, 7458.105027396748, 7475.252474752481, 7502.174760776419, 7593.1647518774, 41772.373414399415, 43717.507798128856, 45001.77499112614, 45089.77455112835, 45105.36182977128, 58467.0, 64325.03512447223, 64422.0, 64944.35055649572, 65196.348036519026, 11639.418029098342, 11667.708307292385, 11710.0, 11786.292822430682, 12342.321172335249, 13409.0, 13545.390457429636, 14029.088109272865, 14066.296685165906, 14504.709905801614, 11106.944465277622, 11264.15518836107, 11264.211505194886, 11583.015443687382, 11588.362640054878, 11686.649400517997, 12051.819222711842, 12054.75890482203, 12102.93948530287, 12124.33316167584, 10969.945150274198, 11014.284071535325, 11199.720006999563, 11413.714657133305, 11688.590899318484, 9693.951530242304, 10004.149647280063, 10028.0, 10160.441175735405, 10193.184545236512, 9569.751108489638, 9920.355176913477, 9946.55240514193, 9954.950225248827, 9997.900020999698], "value": 6449.999397589099, "unit": "score"}], "name": "dromaeo_css", "value": 6401.974904101217, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 131.0, 135.0, 189.0, 130.0, 140.0, 172.0, 132.0, 191.0, 132.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 163.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 131.0, 77.0, 77.0, 76.0, 76.0, 99.0, 76.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 122.0, 85.0, 85.0, 87.0, 117.0, 86.0, 86.0, 125.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 95.0, 95.0, 97.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 66.0, 64.0, 63.0, 63.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 81.0, 84.0, 82.0, 83.0, 84.0, 91.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 131.0, 130.0, 130.0, 126.0, 140.0, 131.0, 133.0, 141.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 165.0, 167.0, 167.0, 171.0, 171.0, 164.0, 164.0, 164.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1545.5999999999997, "alertThreshold": 2.0}]} 15:47:21 INFO - Return code: 0 15:47:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:47:22 INFO - # TBPL SUCCESS # 15:47:22 INFO - Running post-action listener: _resource_record_post_action 15:47:22 INFO - ##### 15:47:22 INFO - ##### Finished run-tests step (success) 15:47:22 INFO - ##### 15:47:22 INFO - Running post-run listener: _resource_record_post_run 15:47:22 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535482368; Read time: 12; Write time: 416600 15:47:22 INFO - TinderboxPrint: CPU usage
13.2% 15:47:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:47:22 INFO - TinderboxPrint: I/O write bytes / time
535,482,368 / 416,600 15:47:22 INFO - TinderboxPrint: CPU idle
8,328.7 (86.8%) 15:47:22 INFO - TinderboxPrint: CPU user
1,216.7 (12.7%) 15:47:22 INFO - TinderboxPrint: Swap in / out
0 / 0 15:47:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246407168; Read time: 0; Write time: 223264 15:47:22 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289075200; Read time: 12; Write time: 193336 15:47:22 INFO - Running post-run listener: _upload_blobber_files 15:47:22 INFO - Blob upload gear active. 15:47:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:22 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 15:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:47:23 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:47:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:47:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:26 INFO - (blobuploader) - INFO - Done attempting. 15:47:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:47:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:47:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:27 INFO - (blobuploader) - INFO - Done attempting. 15:47:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:47:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:28 INFO - (blobuploader) - INFO - Done attempting. 15:47:28 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:28 INFO - Return code: 0 15:47:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57a747788408c169e16b4a3350768a433f0a06ce750ba4d9a6edef56aefe0a38f1eacb2a63723457d2dd187633e71eea928d602acc3843ee985dd7b64f4625ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53c13587ec11454039ccb512f5c1a625b437c0494e6c6976169ae6741292fc6693b18d4cd5dc31ed7e2ff13c6e0b24b18aaf3d287016b06fa90cd9a79e9b424f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb02a4b84e15f368b92ae72122cb69b22dcd7ca331d18dd0a434230366bd532281225cb68d9b62bfec1ee894eec74a57df74887658aee9b1e9a6e9d580ae50a"} 15:47:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:28 INFO - Contents: 15:47:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57a747788408c169e16b4a3350768a433f0a06ce750ba4d9a6edef56aefe0a38f1eacb2a63723457d2dd187633e71eea928d602acc3843ee985dd7b64f4625ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53c13587ec11454039ccb512f5c1a625b437c0494e6c6976169ae6741292fc6693b18d4cd5dc31ed7e2ff13c6e0b24b18aaf3d287016b06fa90cd9a79e9b424f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb02a4b84e15f368b92ae72122cb69b22dcd7ca331d18dd0a434230366bd532281225cb68d9b62bfec1ee894eec74a57df74887658aee9b1e9a6e9d580ae50a"} 15:47:28 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:28 INFO - Copying logs to upload dir... 15:47:28 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.970027 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 15:47:28.063172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 15:47:28.066629) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57a747788408c169e16b4a3350768a433f0a06ce750ba4d9a6edef56aefe0a38f1eacb2a63723457d2dd187633e71eea928d602acc3843ee985dd7b64f4625ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53c13587ec11454039ccb512f5c1a625b437c0494e6c6976169ae6741292fc6693b18d4cd5dc31ed7e2ff13c6e0b24b18aaf3d287016b06fa90cd9a79e9b424f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb02a4b84e15f368b92ae72122cb69b22dcd7ca331d18dd0a434230366bd532281225cb68d9b62bfec1ee894eec74a57df74887658aee9b1e9a6e9d580ae50a"} build_url:https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/b19aXiuZR16YTFEG2rG8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/57a747788408c169e16b4a3350768a433f0a06ce750ba4d9a6edef56aefe0a38f1eacb2a63723457d2dd187633e71eea928d602acc3843ee985dd7b64f4625ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/53c13587ec11454039ccb512f5c1a625b437c0494e6c6976169ae6741292fc6693b18d4cd5dc31ed7e2ff13c6e0b24b18aaf3d287016b06fa90cd9a79e9b424f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb02a4b84e15f368b92ae72122cb69b22dcd7ca331d18dd0a434230366bd532281225cb68d9b62bfec1ee894eec74a57df74887658aee9b1e9a6e9d580ae50a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 15:47:28.091760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:47:28.092073) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467066402.421648-201239651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004739 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:47:28.175270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 15:47:28.175578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 15:47:28.175878) ========= ========= Total master_lag: 0.17 =========