builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1466591074.29 results: success (0) buildid: 20160622004014 builduid: 685f580f13c34733b52cb45522c8f4ce revision: c0ead5950258e5a5db6e4bd9a0714b500b780d8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.290225) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.290689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.290967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.570336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.570676) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 03:24:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-22 03:24:35 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076451 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.676311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.676682) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018916 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.725757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:34.726068) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c0ead5950258e5a5db6e4bd9a0714b500b780d8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c0ead5950258e5a5db6e4bd9a0714b500b780d8d --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=8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 03:24:35,576 truncating revision to first 12 chars 2016-06-22 03:24:35,576 Setting DEBUG logging. 2016-06-22 03:24:35,576 attempt 1/10 2016-06-22 03:24:35,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c0ead5950258?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 03:24:35,880 unpacking tar archive at: mozilla-aurora-c0ead5950258/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:35.396637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:35.396952) ========= script_repo_revision: c0ead5950258e5a5db6e4bd9a0714b500b780d8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:35.397394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:35.397668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:24:35.408792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-22 03:24:35.409110) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:36 INFO - MultiFileLogger online at 20160622 03:24:36 in /builds/slave/test 03:24:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:24:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:36 INFO - {'append_to_log': False, 03:24:36 INFO - 'base_work_dir': '/builds/slave/test', 03:24:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:24:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:36 INFO - 'branch': 'Mozilla-Aurora', 03:24:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:36 INFO - 'config_files': ('talos/linux_config.py',), 03:24:36 INFO - 'default_actions': ('clobber', 03:24:36 INFO - 'read-buildbot-config', 03:24:36 INFO - 'download-and-extract', 03:24:36 INFO - 'populate-webroot', 03:24:36 INFO - 'create-virtualenv', 03:24:36 INFO - 'install', 03:24:36 INFO - 'run-tests'), 03:24:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:36 INFO - 'download_minidump_stackwalk': True, 03:24:36 INFO - 'download_symbols': 'ondemand', 03:24:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:36 INFO - 'installer_path': 'installer.exe', 03:24:36 INFO - 'log_level': 'info', 03:24:36 INFO - 'log_name': 'talos', 03:24:36 INFO - 'log_to_console': True, 03:24:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:36 INFO - 'opt_config_files': (), 03:24:36 INFO - 'pip_index': False, 03:24:36 INFO - 'sps_profile': False, 03:24:36 INFO - 'sps_profile_interval': 0, 03:24:36 INFO - 'suite': 'dromaeojs-e10s', 03:24:36 INFO - 'system_bits': '32', 03:24:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:36 INFO - 'title': 'talos-linux64-ix-041', 03:24:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:36 INFO - 'use_talos_json': True, 03:24:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:36 INFO - 'work_dir': 'build'} 03:24:36 INFO - ##### 03:24:36 INFO - ##### Running clobber step. 03:24:36 INFO - ##### 03:24:36 INFO - Running pre-action listener: _resource_record_pre_action 03:24:36 INFO - Running main action method: clobber 03:24:36 INFO - rmtree: /builds/slave/test/build 03:24:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:36 INFO - Running post-action listener: _resource_record_post_action 03:24:36 INFO - ##### 03:24:36 INFO - ##### Finished clobber step (success) 03:24:36 INFO - ##### 03:24:36 INFO - ##### 03:24:36 INFO - ##### Running read-buildbot-config step. 03:24:36 INFO - ##### 03:24:36 INFO - Running pre-action listener: _resource_record_pre_action 03:24:36 INFO - Running main action method: read_buildbot_config 03:24:36 INFO - Using buildbot properties: 03:24:36 INFO - { 03:24:36 INFO - "project": "", 03:24:36 INFO - "product": "firefox", 03:24:36 INFO - "script_repo_revision": "production", 03:24:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:24:36 INFO - "repository": "", 03:24:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:24:36 INFO - "buildid": "20160622004014", 03:24:36 INFO - "stage_platform": "linux64-pgo", 03:24:36 INFO - "basedir": "/builds/slave/test", 03:24:36 INFO - "nightly_build": "True", 03:24:36 INFO - "buildnumber": 367, 03:24:36 INFO - "slavename": "talos-linux64-ix-041", 03:24:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:24:36 INFO - "platform": "ubuntu64_hw", 03:24:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:24:36 INFO - "branch": "mozilla-aurora", 03:24:36 INFO - "repo_path": "releases/mozilla-aurora", 03:24:36 INFO - "revision": "c0ead5950258e5a5db6e4bd9a0714b500b780d8d", 03:24:36 INFO - "pgo_build": "True", 03:24:36 INFO - "builduid": "685f580f13c34733b52cb45522c8f4ce", 03:24:36 INFO - "slavebuilddir": "test" 03:24:36 INFO - } 03:24:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:24:36 INFO - Running post-action listener: _resource_record_post_action 03:24:36 INFO - ##### 03:24:36 INFO - ##### Finished read-buildbot-config step (success) 03:24:36 INFO - ##### 03:24:36 INFO - ##### 03:24:36 INFO - ##### Running download-and-extract step. 03:24:36 INFO - ##### 03:24:36 INFO - Running pre-action listener: _resource_record_pre_action 03:24:36 INFO - Running main action method: download_and_extract 03:24:36 INFO - mkdir: /builds/slave/test/build/tests 03:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:36 INFO - https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:24:43 INFO - Downloaded 1361 bytes. 03:24:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:24:43 INFO - Using the following test package requirements: 03:24:43 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:24:43 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:24:43 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:24:43 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'jsshell-linux-x86_64.zip'], 03:24:43 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:24:43 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:24:43 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:24:43 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:24:43 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:24:43 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:24:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:43 INFO - https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:44 INFO - Downloaded 24474809 bytes. 03:24:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:24:45 INFO - Return code: 0 03:24:45 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:24: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')]} 03:24:45 INFO - https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:47 INFO - Downloaded 24474809 bytes. 03:24:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:24:49 INFO - Return code: 0 03:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:49 INFO - https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:24:49 INFO - Downloaded 10833369 bytes. 03:24:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:24:50 INFO - Return code: 0 03:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:50 INFO - https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:24:51 INFO - Downloaded 63594894 bytes. 03:24:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:24:51 INFO - mkdir: /builds/slave/test/properties 03:24:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:51 INFO - Contents: 03:24:51 INFO - build_url:https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:24:52 INFO - Running post-action listener: _resource_record_post_action 03:24:52 INFO - Running post-action listener: set_extra_try_arguments 03:24:52 INFO - ##### 03:24:52 INFO - ##### Finished download-and-extract step (success) 03:24:52 INFO - ##### 03:24:52 INFO - ##### 03:24:52 INFO - ##### Running populate-webroot step. 03:24:52 INFO - ##### 03:24:52 INFO - Running pre-action listener: _resource_record_pre_action 03:24:52 INFO - Running main action method: populate_webroot 03:24:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:24:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:24:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:24:52 INFO - '--tppagecycles', 03:24:52 INFO - '7'], 03:24:52 INFO - 'tests': ['tsvgm']}}, 03:24:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:24:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:24:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['damp', 'tps']}, 03:24:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'tests': ['damp', 'tps']}, 03:24:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['dromaeo_dom']}, 03:24:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['a11yr', 03:24:52 INFO - 'ts_paint', 03:24:52 INFO - 'tpaint', 03:24:52 INFO - 'sessionrestore', 03:24:52 INFO - 'sessionrestore_no_auto_restore', 03:24:52 INFO - 'tabpaint']}, 03:24:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:52 INFO - 'ts_paint', 03:24:52 INFO - 'tpaint', 03:24:52 INFO - 'sessionrestore', 03:24:52 INFO - 'sessionrestore_no_auto_restore', 03:24:52 INFO - 'tabpaint']}, 03:24:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:24:52 INFO - 'ts_paint', 03:24:52 INFO - 'tpaint', 03:24:52 INFO - 'sessionrestore', 03:24:52 INFO - 'sessionrestore_no_auto_restore', 03:24:52 INFO - 'tabpaint']}, 03:24:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:24:52 INFO - 'ts_paint', 03:24:52 INFO - 'tpaint', 03:24:52 INFO - 'sessionrestore', 03:24:52 INFO - 'sessionrestore_no_auto_restore', 03:24:52 INFO - 'tabpaint']}, 03:24:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['a11yr', 03:24:52 INFO - 'ts_paint', 03:24:52 INFO - 'tpaint', 03:24:52 INFO - 'sessionrestore', 03:24:52 INFO - 'sessionrestore_no_auto_restore', 03:24:52 INFO - 'tabpaint']}, 03:24:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['a11yr', 03:24:52 INFO - 'ts_paint', 03:24:52 INFO - 'tpaint', 03:24:52 INFO - 'sessionrestore', 03:24:52 INFO - 'sessionrestore_no_auto_restore', 03:24:52 INFO - 'tabpaint']}, 03:24:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['tsvgx', 03:24:52 INFO - 'tsvgr_opacity', 03:24:52 INFO - 'tart', 03:24:52 INFO - 'tscrollx', 03:24:52 INFO - 'cart']}, 03:24:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:52 INFO - 'tsvgr_opacity', 03:24:52 INFO - 'tart', 03:24:52 INFO - 'tscrollx', 03:24:52 INFO - 'cart']}, 03:24:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'talos_options': ['--disable-e10s'], 03:24:52 INFO - 'tests': ['tp5o']}, 03:24:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'tests': ['tp5o']}, 03:24:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'talos_options': ['--disable-e10s', 03:24:52 INFO - '--xperf_path', 03:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:52 INFO - 'tests': ['tp5n']}, 03:24:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:52 INFO - 'talos_options': ['--xperf_path', 03:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:52 INFO - 'tests': ['tp5n']}}, 03:24:52 INFO - 'talos.zip': {'path': '', 03:24:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:24:52 INFO - Running post-action listener: _resource_record_post_action 03:24:52 INFO - ##### 03:24:52 INFO - ##### Finished populate-webroot step (success) 03:24:52 INFO - ##### 03:24:52 INFO - ##### 03:24:52 INFO - ##### Running create-virtualenv step. 03:24:52 INFO - ##### 03:24:52 INFO - Running pre-action listener: _resource_record_pre_action 03:24:52 INFO - Running main action method: create_virtualenv 03:24:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:24:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:24:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:52 INFO - Using real prefix '/usr' 03:24:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:54 INFO - Installing pip.................done. 03:24:54 INFO - Return code: 0 03:24:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:24:54 INFO - Using env: {'DISPLAY': ':0', 03:24:54 INFO - 'HOME': '/home/cltbld', 03:24:54 INFO - 'LANG': 'en_US.UTF-8', 03:24:54 INFO - 'LANGUAGE': 'en_US:en', 03:24:54 INFO - 'LOGNAME': 'cltbld', 03:24:54 INFO - 'MAIL': '/var/mail/cltbld', 03:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:54 INFO - 'MOZ_NO_REMOTE': '1', 03:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:54 INFO - 'NO_EM_RESTART': '1', 03:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:54 INFO - 'PWD': '/builds/slave/test', 03:24:54 INFO - 'SHELL': '/bin/bash', 03:24:54 INFO - 'SHLVL': '1', 03:24:54 INFO - 'TERM': 'linux', 03:24:54 INFO - 'TMOUT': '86400', 03:24:54 INFO - 'USER': 'cltbld', 03:24:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:54 INFO - '_': '/tools/buildbot/bin/python'} 03:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:24:55 INFO - Cleaning up... 03:24:55 INFO - Return code: 0 03:24:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:24:55 INFO - Using env: {'DISPLAY': ':0', 03:24:55 INFO - 'HOME': '/home/cltbld', 03:24:55 INFO - 'LANG': 'en_US.UTF-8', 03:24:55 INFO - 'LANGUAGE': 'en_US:en', 03:24:55 INFO - 'LOGNAME': 'cltbld', 03:24:55 INFO - 'MAIL': '/var/mail/cltbld', 03:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:55 INFO - 'MOZ_NO_REMOTE': '1', 03:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:55 INFO - 'NO_EM_RESTART': '1', 03:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:55 INFO - 'PWD': '/builds/slave/test', 03:24:55 INFO - 'SHELL': '/bin/bash', 03:24:55 INFO - 'SHLVL': '1', 03:24:55 INFO - 'TERM': 'linux', 03:24:55 INFO - 'TMOUT': '86400', 03:24:55 INFO - 'USER': 'cltbld', 03:24:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:55 INFO - '_': '/tools/buildbot/bin/python'} 03:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:55 INFO - Downloading/unpacking psutil>=3.1.1 03:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:57 INFO - Installing collected packages: psutil 03:24:57 INFO - Running setup.py install for psutil 03:24:57 INFO - building 'psutil._psutil_linux' extension 03:24:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:24:57 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 03:24:57 INFO - building 'psutil._psutil_posix' extension 03:24:57 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 03:24:57 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 03:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:57 INFO - Successfully installed psutil 03:24:57 INFO - Cleaning up... 03:24:57 INFO - Return code: 0 03:24:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:24: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')]} 03:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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')]} 03:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:24:57 INFO - Using env: {'DISPLAY': ':0', 03:24:57 INFO - 'HOME': '/home/cltbld', 03:24:57 INFO - 'LANG': 'en_US.UTF-8', 03:24:57 INFO - 'LANGUAGE': 'en_US:en', 03:24:57 INFO - 'LOGNAME': 'cltbld', 03:24:57 INFO - 'MAIL': '/var/mail/cltbld', 03:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:57 INFO - 'MOZ_NO_REMOTE': '1', 03:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:57 INFO - 'NO_EM_RESTART': '1', 03:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:57 INFO - 'PWD': '/builds/slave/test', 03:24:57 INFO - 'SHELL': '/bin/bash', 03:24:57 INFO - 'SHLVL': '1', 03:24:57 INFO - 'TERM': 'linux', 03:24:57 INFO - 'TMOUT': '86400', 03:24:57 INFO - 'USER': 'cltbld', 03:24:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:57 INFO - '_': '/tools/buildbot/bin/python'} 03:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:00 INFO - Installing collected packages: mozsystemmonitor 03:25:00 INFO - Running setup.py install for mozsystemmonitor 03:25:00 INFO - Successfully installed mozsystemmonitor 03:25:00 INFO - Cleaning up... 03:25:00 INFO - Return code: 0 03:25:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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', '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 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:25: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 jsonschema==2.5.1 03:25:00 INFO - Using env: {'DISPLAY': ':0', 03:25:00 INFO - 'HOME': '/home/cltbld', 03:25:00 INFO - 'LANG': 'en_US.UTF-8', 03:25:00 INFO - 'LANGUAGE': 'en_US:en', 03:25:00 INFO - 'LOGNAME': 'cltbld', 03:25:00 INFO - 'MAIL': '/var/mail/cltbld', 03:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:00 INFO - 'MOZ_NO_REMOTE': '1', 03:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:00 INFO - 'NO_EM_RESTART': '1', 03:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:00 INFO - 'PWD': '/builds/slave/test', 03:25:00 INFO - 'SHELL': '/bin/bash', 03:25:00 INFO - 'SHLVL': '1', 03:25:00 INFO - 'TERM': 'linux', 03:25:00 INFO - 'TMOUT': '86400', 03:25:00 INFO - 'USER': 'cltbld', 03:25:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:00 INFO - '_': '/tools/buildbot/bin/python'} 03:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:00 INFO - Downloading/unpacking jsonschema==2.5.1 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:02 INFO - warning: no files found matching '*.txt' 03:25:02 INFO - no previously-included directories found matching 'build' 03:25:02 INFO - no previously-included directories found matching 'dist' 03:25:02 INFO - no previously-included directories found matching '.git*' 03:25:02 INFO - Installing collected packages: jsonschema, functools32 03:25:02 INFO - Running setup.py install for functools32 03:25:02 INFO - warning: no files found matching '*.txt' 03:25:02 INFO - no previously-included directories found matching 'build' 03:25:02 INFO - no previously-included directories found matching 'dist' 03:25:02 INFO - no previously-included directories found matching '.git*' 03:25:02 INFO - Successfully installed jsonschema functools32 03:25:02 INFO - Cleaning up... 03:25:02 INFO - Return code: 0 03:25:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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', '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 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25: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 blobuploader==1.2.4 03:25:02 INFO - Using env: {'DISPLAY': ':0', 03:25:02 INFO - 'HOME': '/home/cltbld', 03:25:02 INFO - 'LANG': 'en_US.UTF-8', 03:25:02 INFO - 'LANGUAGE': 'en_US:en', 03:25:02 INFO - 'LOGNAME': 'cltbld', 03:25:02 INFO - 'MAIL': '/var/mail/cltbld', 03:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:02 INFO - 'MOZ_NO_REMOTE': '1', 03:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:02 INFO - 'NO_EM_RESTART': '1', 03:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:02 INFO - 'PWD': '/builds/slave/test', 03:25:02 INFO - 'SHELL': '/bin/bash', 03:25:02 INFO - 'SHLVL': '1', 03:25:02 INFO - 'TERM': 'linux', 03:25:02 INFO - 'TMOUT': '86400', 03:25:02 INFO - 'USER': 'cltbld', 03:25:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:02 INFO - '_': '/tools/buildbot/bin/python'} 03:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:05 INFO - Downloading docopt-0.6.1.tar.gz 03:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:05 INFO - Running setup.py install for blobuploader 03:25:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:05 INFO - Running setup.py install for requests 03:25:06 INFO - Running setup.py install for docopt 03:25:06 INFO - Successfully installed blobuploader requests docopt 03:25:06 INFO - Cleaning up... 03:25:06 INFO - Return code: 0 03:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:06 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 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:25:06 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 03:25:06 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 03:25:06 INFO - Using env: {'DISPLAY': ':0', 03:25:06 INFO - 'HOME': '/home/cltbld', 03:25:06 INFO - 'LANG': 'en_US.UTF-8', 03:25:06 INFO - 'LANGUAGE': 'en_US:en', 03:25:06 INFO - 'LOGNAME': 'cltbld', 03:25:06 INFO - 'MAIL': '/var/mail/cltbld', 03:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:06 INFO - 'MOZ_NO_REMOTE': '1', 03:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:06 INFO - 'NO_EM_RESTART': '1', 03:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:06 INFO - 'PWD': '/builds/slave/test', 03:25:06 INFO - 'SHELL': '/bin/bash', 03:25:06 INFO - 'SHLVL': '1', 03:25:06 INFO - 'TERM': 'linux', 03:25:06 INFO - 'TMOUT': '86400', 03:25:06 INFO - 'USER': 'cltbld', 03:25:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:06 INFO - '_': '/tools/buildbot/bin/python'} 03:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:06 INFO - Running setup.py (path:/tmp/pip-maDCtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:06 INFO - Running setup.py (path:/tmp/pip-9BKgoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:06 INFO - Running setup.py (path:/tmp/pip-Hadmcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:06 INFO - Running setup.py (path:/tmp/pip-sKdHMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:06 INFO - Running setup.py (path:/tmp/pip-9SzDJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:06 INFO - Running setup.py (path:/tmp/pip-xks0e0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:06 INFO - Running setup.py (path:/tmp/pip-i9B7Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:06 INFO - Running setup.py (path:/tmp/pip-lbHbus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:07 INFO - Running setup.py (path:/tmp/pip-ZrdbkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:07 INFO - Running setup.py (path:/tmp/pip-qfnovV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:07 INFO - Running setup.py (path:/tmp/pip-rjQTWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:07 INFO - Running setup.py (path:/tmp/pip-Kp_ZA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:07 INFO - Running setup.py (path:/tmp/pip-ZsxqFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:07 INFO - Running setup.py (path:/tmp/pip-KYAkTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:07 INFO - Running setup.py (path:/tmp/pip-5ABbMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:07 INFO - Running setup.py (path:/tmp/pip-V6p5st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:07 INFO - Running setup.py (path:/tmp/pip-hPFwit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:07 INFO - Running setup.py install for manifestparser 03:25:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:07 INFO - Running setup.py install for mozcrash 03:25:07 INFO - Running setup.py install for mozdebug 03:25:08 INFO - Running setup.py install for mozdevice 03:25:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Running setup.py install for mozfile 03:25:08 INFO - Running setup.py install for mozhttpd 03:25:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Running setup.py install for mozinfo 03:25:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Running setup.py install for mozInstall 03:25:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Running setup.py install for mozleak 03:25:08 INFO - Running setup.py install for mozlog 03:25:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Running setup.py install for moznetwork 03:25:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:08 INFO - Running setup.py install for mozprocess 03:25:08 INFO - Running setup.py install for mozprofile 03:25:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:09 INFO - Running setup.py install for mozrunner 03:25:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:09 INFO - Running setup.py install for mozscreenshot 03:25:09 INFO - Running setup.py install for moztest 03:25:09 INFO - Running setup.py install for mozversion 03:25:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:09 INFO - Cleaning up... 03:25:09 INFO - Return code: 0 03:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:09 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')]} 03:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:09 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')]} 03:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:09 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 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:25:09 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 03:25:09 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 03:25:09 INFO - Using env: {'DISPLAY': ':0', 03:25:09 INFO - 'HOME': '/home/cltbld', 03:25:09 INFO - 'LANG': 'en_US.UTF-8', 03:25:09 INFO - 'LANGUAGE': 'en_US:en', 03:25:09 INFO - 'LOGNAME': 'cltbld', 03:25:09 INFO - 'MAIL': '/var/mail/cltbld', 03:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:09 INFO - 'MOZ_NO_REMOTE': '1', 03:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:09 INFO - 'NO_EM_RESTART': '1', 03:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:09 INFO - 'PWD': '/builds/slave/test', 03:25:09 INFO - 'SHELL': '/bin/bash', 03:25:09 INFO - 'SHLVL': '1', 03:25:09 INFO - 'TERM': 'linux', 03:25:09 INFO - 'TMOUT': '86400', 03:25:09 INFO - 'USER': 'cltbld', 03:25:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:09 INFO - '_': '/tools/buildbot/bin/python'} 03:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:09 INFO - Running setup.py (path:/tmp/pip-7c1Zdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:09 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)) 03:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:09 INFO - Running setup.py (path:/tmp/pip-OfQzQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:09 INFO - Running setup.py (path:/tmp/pip-C_1dES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:09 INFO - Running setup.py (path:/tmp/pip-pMYTwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:10 INFO - Running setup.py (path:/tmp/pip-ppBFcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:10 INFO - Running setup.py (path:/tmp/pip-0KEsdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:10 INFO - Running setup.py (path:/tmp/pip-W6R0yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:10 INFO - Running setup.py (path:/tmp/pip-FXCvik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:10 INFO - Running setup.py (path:/tmp/pip-uWpnq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:10 INFO - Running setup.py (path:/tmp/pip-Q3AZGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:10 INFO - Running setup.py (path:/tmp/pip-pcwwIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:10 INFO - Running setup.py (path:/tmp/pip-VhFEI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:10 INFO - Running setup.py (path:/tmp/pip-XXikz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:10 INFO - Running setup.py (path:/tmp/pip-JS2NO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:10 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)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:10 INFO - Running setup.py (path:/tmp/pip-YXCL7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:10 INFO - Running setup.py (path:/tmp/pip-jULQoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:10 INFO - Running setup.py (path:/tmp/pip-yA7D5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:11 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 03:25:11 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 03:25:11 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 03:25:11 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 03:25:11 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 03:25:11 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 03:25:12 INFO - Downloading blessings-1.6.tar.gz 03:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:12 INFO - Installing collected packages: blessings 03:25:12 INFO - Running setup.py install for blessings 03:25:13 INFO - Successfully installed blessings 03:25:13 INFO - Cleaning up... 03:25:13 INFO - Return code: 0 03:25:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:13 INFO - Reading from file tmpfile_stdout 03:25:13 INFO - Current package versions: 03:25:13 INFO - argparse == 1.2.1 03:25:13 INFO - blessings == 1.6 03:25:13 INFO - blobuploader == 1.2.4 03:25:13 INFO - docopt == 0.6.1 03:25:13 INFO - functools32 == 3.2.3-2 03:25:13 INFO - jsonschema == 2.5.1 03:25:13 INFO - manifestparser == 1.1 03:25:13 INFO - mozInstall == 1.12 03:25:13 INFO - mozcrash == 0.17 03:25:13 INFO - mozdebug == 0.1 03:25:13 INFO - mozdevice == 0.48 03:25:13 INFO - mozfile == 1.2 03:25:13 INFO - mozhttpd == 0.7 03:25:13 INFO - mozinfo == 0.9 03:25:13 INFO - mozleak == 0.1 03:25:13 INFO - mozlog == 3.2 03:25:13 INFO - moznetwork == 0.27 03:25:13 INFO - mozprocess == 0.22 03:25:13 INFO - mozprofile == 0.28 03:25:13 INFO - mozrunner == 6.11 03:25:13 INFO - mozscreenshot == 0.1 03:25:13 INFO - mozsystemmonitor == 0.3 03:25:13 INFO - moztest == 0.7 03:25:13 INFO - mozversion == 1.4 03:25:13 INFO - psutil == 3.1.1 03:25:13 INFO - requests == 1.2.3 03:25:13 INFO - wsgiref == 0.1.2 03:25:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:13 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')]} 03:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:13 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')]} 03:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:13 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 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:25:13 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 03:25:13 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 03:25:13 INFO - Using env: {'DISPLAY': ':0', 03:25:13 INFO - 'HOME': '/home/cltbld', 03:25:13 INFO - 'LANG': 'en_US.UTF-8', 03:25:13 INFO - 'LANGUAGE': 'en_US:en', 03:25:13 INFO - 'LOGNAME': 'cltbld', 03:25:13 INFO - 'MAIL': '/var/mail/cltbld', 03:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:13 INFO - 'MOZ_NO_REMOTE': '1', 03:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:13 INFO - 'NO_EM_RESTART': '1', 03:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:13 INFO - 'PWD': '/builds/slave/test', 03:25:13 INFO - 'SHELL': '/bin/bash', 03:25:13 INFO - 'SHLVL': '1', 03:25:13 INFO - 'TERM': 'linux', 03:25:13 INFO - 'TMOUT': '86400', 03:25:13 INFO - 'USER': 'cltbld', 03:25:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:13 INFO - '_': '/tools/buildbot/bin/python'} 03:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 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)) 03:25:13 INFO - Cleaning up... 03:25:13 INFO - Return code: 0 03:25:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25:13 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')]} 03:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:13 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')]} 03:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:13 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 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:25:13 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 03:25:13 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 03:25:13 INFO - Using env: {'DISPLAY': ':0', 03:25:13 INFO - 'HOME': '/home/cltbld', 03:25:13 INFO - 'LANG': 'en_US.UTF-8', 03:25:13 INFO - 'LANGUAGE': 'en_US:en', 03:25:13 INFO - 'LOGNAME': 'cltbld', 03:25:13 INFO - 'MAIL': '/var/mail/cltbld', 03:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:13 INFO - 'MOZ_NO_REMOTE': '1', 03:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:13 INFO - 'NO_EM_RESTART': '1', 03:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:13 INFO - 'PWD': '/builds/slave/test', 03:25:13 INFO - 'SHELL': '/bin/bash', 03:25:13 INFO - 'SHLVL': '1', 03:25:13 INFO - 'TERM': 'linux', 03:25:13 INFO - 'TMOUT': '86400', 03:25:13 INFO - 'USER': 'cltbld', 03:25:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:13 INFO - '_': '/tools/buildbot/bin/python'} 03:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:13 INFO - Cleaning up... 03:25:13 INFO - Return code: 0 03:25:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:25:13 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')]} 03:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:13 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')]} 03:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:13 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 0x7f21f7a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', '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 03:25:13 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 03:25:13 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 03:25:13 INFO - Using env: {'DISPLAY': ':0', 03:25:13 INFO - 'HOME': '/home/cltbld', 03:25:13 INFO - 'LANG': 'en_US.UTF-8', 03:25:13 INFO - 'LANGUAGE': 'en_US:en', 03:25:13 INFO - 'LOGNAME': 'cltbld', 03:25:13 INFO - 'MAIL': '/var/mail/cltbld', 03:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:13 INFO - 'MOZ_NO_REMOTE': '1', 03:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:13 INFO - 'NO_EM_RESTART': '1', 03:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:13 INFO - 'PWD': '/builds/slave/test', 03:25:13 INFO - 'SHELL': '/bin/bash', 03:25:13 INFO - 'SHLVL': '1', 03:25:13 INFO - 'TERM': 'linux', 03:25:13 INFO - 'TMOUT': '86400', 03:25:13 INFO - 'USER': 'cltbld', 03:25:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:13 INFO - '_': '/tools/buildbot/bin/python'} 03:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:13 INFO - Downloading/unpacking flake8 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:25:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:25:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:16 INFO - no previously-included directories found matching 'docs/_build' 03:25:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:25:16 INFO - Running setup.py install for pep8 03:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:16 INFO - no previously-included directories found matching 'docs/_build' 03:25:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:25:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:25:16 INFO - Cleaning up... 03:25:16 INFO - Return code: 0 03:25:16 INFO - Running post-action listener: _resource_record_post_action 03:25:16 INFO - Running post-action listener: _start_resource_monitoring 03:25:16 INFO - Starting resource monitoring. 03:25:16 INFO - ##### 03:25:16 INFO - ##### Finished create-virtualenv step (success) 03:25:16 INFO - ##### 03:25:16 INFO - ##### 03:25:16 INFO - ##### Running install step. 03:25:16 INFO - ##### 03:25:16 INFO - Running pre-action listener: _resource_record_pre_action 03:25:16 INFO - Running main action method: install 03:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:17 INFO - Reading from file tmpfile_stdout 03:25:17 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:17 INFO - Reading from file tmpfile_stdout 03:25:17 INFO - Output received: 03:25:17 INFO - Usage: mozinstall [options] installer 03:25:17 INFO - Options: 03:25:17 INFO - -h, --help show this help message and exit 03:25:17 INFO - -d DEST, --destination=DEST 03:25:17 INFO - Directory to install application into. [default: 03:25:17 INFO - "/builds/slave/test"] 03:25:17 INFO - --app=APP Application being installed. [default: firefox] 03:25:17 INFO - mkdir: /builds/slave/test/build/application 03:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:25:33 INFO - Reading from file tmpfile_stdout 03:25:33 INFO - Output received: 03:25:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:25:33 INFO - Running post-action listener: _resource_record_post_action 03:25:33 INFO - ##### 03:25:33 INFO - ##### Finished install step (success) 03:25:33 INFO - ##### 03:25:33 INFO - ##### 03:25:33 INFO - ##### Running run-tests step. 03:25:33 INFO - ##### 03:25:33 INFO - Running pre-action listener: _resource_record_pre_action 03:25:33 INFO - Running main action method: run_tests 03:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:33 INFO - Python 2.7.3 03:25:33 INFO - Return code: 0 03:25:33 INFO - grabbing minidump binary from tooltool 03:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:33 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 0x24bc1c0>, '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 0x24bd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bd550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:33 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 03:25:33 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 03:25:33 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 03:25:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:33 INFO - Return code: 0 03:25:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:25:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:25:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:25:34 INFO - Return code: 0 03:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:25:34 INFO - Using env: {'DISPLAY': ':0', 03:25:34 INFO - 'HOME': '/home/cltbld', 03:25:34 INFO - 'LANG': 'en_US.UTF-8', 03:25:34 INFO - 'LANGUAGE': 'en_US:en', 03:25:34 INFO - 'LOGNAME': 'cltbld', 03:25:34 INFO - 'MAIL': '/var/mail/cltbld', 03:25:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:34 INFO - 'MOZ_NO_REMOTE': '1', 03:25:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:34 INFO - 'NO_EM_RESTART': '1', 03:25:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:34 INFO - 'PWD': '/builds/slave/test', 03:25:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:34 INFO - 'SHELL': '/bin/bash', 03:25:34 INFO - 'SHLVL': '1', 03:25:34 INFO - 'TERM': 'linux', 03:25:34 INFO - 'TMOUT': '86400', 03:25:34 INFO - 'USER': 'cltbld', 03:25:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864', 03:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:34 INFO - '_': '/tools/buildbot/bin/python'} 03:25:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:25:34 INFO - mozversion application_buildid: 20160622004014 03:25:34 INFO - mozversion application_changeset: c0ead5950258e5a5db6e4bd9a0714b500b780d8d 03:25:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:25:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:34 INFO - mozversion application_name: Firefox 03:25:34 INFO - mozversion application_remotingname: firefox-dev 03:25:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:34 INFO - mozversion application_vendor: Mozilla 03:25:34 INFO - mozversion application_version: 49.0a2 03:25:34 INFO - mozversion platform_buildid: 20160622004014 03:25:34 INFO - mozversion platform_changeset: c0ead5950258e5a5db6e4bd9a0714b500b780d8d 03:25:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:34 INFO - mozversion platform_version: 49.0a2 03:25:34 INFO - using testdate: 1466591134 03:25:34 INFO - actual date: 1466591134 03:25:34 INFO - starting webserver on 'localhost:40296' 03:25:34 INFO - SUITE-START | Running 2 tests 03:25:34 INFO - TEST-START | dromaeo_css 03:25:34 INFO - operating with platform_type : linux_ 03:25:34 INFO - Initialising browser for dromaeo_css test... 03:25:34 INFO - TEST-INFO | started process 10552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRB2l6U/profile http://localhost:40296/getInfo.html) 03:25:38 INFO - PROCESS | 10552 | __metrics Screen width/height:1600/1200 03:25:38 INFO - PROCESS | 10552 | colorDepth:24 03:25:38 INFO - PROCESS | 10552 | Browser inner width/height: 1024/697 03:25:38 INFO - PROCESS | 10552 | __metrics 03:25:39 ERROR - PROCESS | 10552 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:25:40 INFO - TEST-INFO | 10552: exit 0 03:25:40 INFO - Browser initialized. 03:25:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:40 INFO - TEST-INFO | started process 10679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRB2l6U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:52 INFO - PROCESS | 10679 | RSS: Main: 156053504 03:25:52 INFO - PROCESS | 10679 | 03:26:41 INFO - PROCESS | 10679 | 1466591201898 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] 03:28:50 INFO - PROCESS | 10679 | Cycle 1(1): loaded http://localhost:40296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40296/tests/dromaeo/cssquery-ext.html) 03:28:51 INFO - PROCESS | 10679 | RSS: Main: 159739904 03:28:51 INFO - PROCESS | 10679 | 03:31:53 INFO - PROCESS | 10679 | Cycle 1(1): loaded http://localhost:40296/tests/dromaeo/cssquery-ext.html (next: http://localhost:40296/tests/dromaeo/cssquery-jquery.html) 03:31:53 INFO - PROCESS | 10679 | RSS: Main: 157921280 03:31:53 INFO - PROCESS | 10679 | 03:34:55 INFO - PROCESS | 10679 | Cycle 1(1): loaded http://localhost:40296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40296/tests/dromaeo/cssquery-mootools.html) 03:34:55 INFO - PROCESS | 10679 | RSS: Main: 157450240 03:34:55 INFO - PROCESS | 10679 | 03:37:57 INFO - PROCESS | 10679 | Cycle 1(1): loaded http://localhost:40296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40296/tests/dromaeo/cssquery-prototype.html) 03:37:58 INFO - PROCESS | 10679 | RSS: Main: 155885568 03:37:58 INFO - PROCESS | 10679 | 03:41:00 INFO - PROCESS | 10679 | Cycle 1(1): loaded http://localhost:40296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40296/tests/dromaeo/cssquery-yui.html) 03:41:01 INFO - PROCESS | 10679 | RSS: Main: 157908992 03:41:01 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | Cycle 1(1): loaded http://localhost:40296/tests/dromaeo/cssquery-yui.html (next: http://localhost:40296/tests/dromaeo/cssquery-dojo.html) 03:44:03 INFO - PROCESS | 10679 | RSS: Main: 158142464 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | __start_tp_report 03:44:03 INFO - PROCESS | 10679 | _x_x_mozilla_page_load 03:44:03 INFO - PROCESS | 10679 | _x_x_mozilla_page_load_details 03:44:03 INFO - PROCESS | 10679 | |i|pagename|runs| 03:44:03 INFO - PROCESS | 10679 | |0;dojo.html;3443.5006923996016;3466.7053300469443;3486.0587641336824;3496.440569508879;3498.038039539126;5689.061304884694;5719.256496655435;5743.770249190027;5773.711314434283;5807.796727114546;5743.770249190027;5839;5845.56158288128;5853.560982926287;5872.324682661495;5225.451327610604;5228.29418028566;5267.394249661281;5283.339582552181;5314.1497360422145;5094.541491265785;5104.795808167669;5181.766820493068;5257.290265814124;5281.815136470224;5193.870153246161;5210.687358758468;5216.76524556394;5228.424873263957;5258.842234732964;5217.269582258468;5262.500062494057;5272.420033796279;5280.656757310801;5317.548008419289;4946.96113816099;4997.90004199914;5156.303898973628;5184.585233181337;5253.343332083489;5508.834734957958;5583.637063590853;5586.664800112007;5627.127795191711;5638.182463542763;6109.205803245594;6140.109684095826;6148;6148.477379422754;6174.598651087665;6007.4893634041155;6094.177286066369;6136.723847426876;6197.225346831646;6208.751649933997;5737.340205876378;5749.942500574983;5772.422757724236;5776.711164441803;5807.361190269067;6311.2426508819235;6316.715747791361;6322.36776322364;6327.810165695037;6335.144755458046;5872.941270587239;5976.760929562855;6027.969860150672;6050.092486127028;6076.240469941257;6167.691615419211;6193;6198.504119670415;6202.968985155136;6206.565540412128;6089.878202435926;6106.358832322631;6159.168512250879;6179.6910154493;6221.06683997395;5960.135780311917;6072.453479186806;6103.6032657877095;6139.969300153471;6192.907106393408;4698.506656801055;4699.671023028423;4722.574968252805;4731.219348807408;4741.146593613183;4121.443605113332;4180.184863951561;4205.306124489425;4208.095259519218;4241.491021077491;5699.772009119672;5867.735951882176;5870.970645146747;5935.0207215808905;5956.493698035629;6237.064440333896;6237.625742455467;6309.432151106423;6338.7464501420345;6372.394622510854;5775.595708300379;6036.667983260875;6054.455099041019;6082.665453400017;6084.908726369108;5293.973530132324;5356.91964620531;5365.570754339644;5396.4333744957;5414.269073675004;6474.902876456857;6488.708008139645;6525.902111468332;6529.053287273318;6530.05314229434;5892.440218179266;6073.392660733891;6270.686465676789;6325.810225693236;6326.398992095744;6263.812085637438;6341.0805433212845;6350.618962862243;6353.396427339396;6356.713947872265;6029.4874935629205;6076.665783381956;6088.025915853619;6092.208012958465;6127.662978536223;5985.25184351956;6119.136988620051;6130.0006981778415;6183.536234782499;6210.720517576629;6118.223266370627;6120.632762034292;6132.544012458836;6138.907916381348;6142.262928448615;6106.175666284995;6123.2958209804665;6128;6133.417325354084;6139.723712432862;5804.1874137619925;5851.502622276984;5877.941220587911;5917.497012753965;6030.095485677183;6051.1830902829315;6096.451319381277;6103.664298463627;6112.235970503687;6122.755089796537;5925.970370148121;5961.463468287875;5978.611390259619;5990.460858522754;5991 03:44:03 INFO - PROCESS | 10679 | |1;ext.html;585.8213244960285;618.0111821086261;639.0892977507053;644.2333622988643;684.3327755438445;39546;44087.77956110219;44293;44401.333979990326;44491.55508444919;43772;44491.11017779651;45036.77481612596;45168.77415612926;45172;8799.2080712736;8870.822583548324;8932.866007009867;8933.55332233389;8952.373333866632;8850.867236991418;8892.15524525169;8913.509756963364;8942.64229430822;8948.507832069234;8987.595558199864;9003;9014.188723014928;9028.368014239006;9057;8950.41822281553;8963.058878817761;8970.013298537187;8993.730188094367;9005.054469280762;8752.081031491729;8802.735917922473;8806.295496360275;8843;8876.778080547974;42773.57226427727;43047.35428968568;43112.13775724468;43345.13309733788;43395.78302108501;3693.372126738434;3805.086779173006;3805.8858234253016;3889.3193691103943;4162.375643653446;33340;33601;34073.659263407295;36174;36461;4604.608608268301;4607.216773148572;4701.952980470186;4787.928181077286;4908.754562271908;359912;361990;362407;363474;363778;65254;65415.34584654093;66207.33792662012;66419.66790166018;66527;38460.23079538393;39485.60514394877;39579.406308904814;41628.37557436641;41652.58347416487;15565.610859728371;15723.764143537855;15742.212889355487;15744.134072626115;15778.13220272896;12728.80906786399;12824.551140710031;12850.42173102194;12861.678458038437;12897;21053.47366315824;21058.684119738216;21235.893820531106;21310.573788524143;21330.680039799416;7660.463767536219;7667.348275396542;7679;7849.646765895548;7950.562719050507;973.3867663372031;1044.7231483656838;1055.6410820321128;1089.215764649451;1095.2552264460085;33170;33358.83320583381;33532.49701254483;33647.99056028323;33673.49489757656;1128.2835399521364;1154.4977934598476;1216.3188614375802;1218.5674085699627;1220.4446976625613;17180.656386872193;17234.535064519405;17356;17601;17808.732869006973;549035;561642;565632;571620;894521;62624.68687656533;62844.371556283855;62914.0562891557;62963;63259;1454.2873991744182;1499.452699764578;1512.3345727879478;1516.9317380717894;1521.3230112600008;32928;33481.83259083689;33652.831735841166;34118.65881341254;34606;53248.46751532435;53840;53886.73056634849;53900;53903.19145212903;555488;558198;560407;560497;561088;30165.396692066475;31410.371792564478;31428.057158285286;31456.842715786275;31459.84270078635;50322.2451663218;50890.23664645107;51392.229116562536;51414.22878656898;51613.22580161376;41284;42936.14127717491;43932.341014884165;47535.762321189555;47945.76027119842;43583;44051.77974110109;44592.77703611461;45136.54863451324;45650.77174614106;42765;43589;43721.25114995365;43839.34240986324;44870.3269450952;37819;38216.80891595524;38364.80817595894;39036;39112.80443597764;29243;29314.41371172522;29390.55914161332;29705.702942970292;29812.254693632833 03:44:03 INFO - PROCESS | 10679 | |2;jquery.html;424.1919144030619;437.13447374199086;438.6446977947862;438.67099675243566;444.7998400719677;18072.728909066358;19105.331313404033;19884.204631814748;19895.701564476527;19926;17027.06351150686;18074.728879066824;19928;20100.899495502537;20105.095270712816;4855.757212139397;5173.405058418292;5184.507471790174;5226.608004399666;5235.188545775411;5104.2088476286235;5136.43499215086;5149.562287205592;5344.144936810111;5397.190421436777;5310.230016647583;5363.570914326864;5373.75818088185;5407.648502847303;5411.756470958797;5297.841064768063;5387.380451248097;5486.286782718261;5776.9422305776825;5783.248177736909;5471.863203419906;5645.633033852787;5693.316801983747;5721.199032135504;5749.683767392792;13671.658208544766;13695.863041369657;13720.588382348546;14407.207603581799;23276.185333513415;2294.265834932822;2343.168175297762;2408.2414039577475;2423.4067563747126;2567.242663414297;9768.51157442125;9935.254855885765;10268.640597579124;10433.113185379252;10553.366797992145;1695.1354809047475;1751.4395393474094;1871.363736329641;1930.5849242412808;1937.883726976372;83918.58040709818;84849.57575212145;85833;86578.56710716407;86981;11409.543618255177;11661.35862527569;11828;12015.819762703566;12299.815502767466;16909.915450422915;16935.915320423566;17000.149992500326;17026.404075857532;17028;8518.57407129641;8581.141885811494;8632.525211113449;8661.696840610548;8767.517786521803;8242.711505097413;8252.8349433011;8292.751217463485;8386.622601982925;8453.915460845314;4943.406791185081;5054.873628159252;5063.696178229318;5113.51421614946;5214.478552144831;1859.1355019915804;1895.9620807583772;1933.3716542123866;1939.9030048497518;1943.7959014303294;1010.3887148275335;1056.3081181825917;1064.4252103863982;1091.1380009792333;1110.3227031510771;19232.23071077141;19503.902480487508;20024.69962950557;20029.29897453582;20566.69149962752;1018.2464975917916;1022.3610243597751;1035.4977835749655;1053.4627340056472;1101.7521057762099;10999.560017599366;11209.103271738242;11227.38249396291;11297.209195356247;11339.773204535863;467686;488527;491400;494480;503493;84253;93293;101143;102213;104368;1079.9956040882055;1115.2304909612503;1116.1294190531398;1122.5565901468874;1137.6530158301798;18726.127387261164;18994.52513687169;19028.524286892938;19051.14269857832;19164.520886977938;39648.2070358597;41509.37735933903;44413.11173776571;45755;46117.07765844731;56503.43496565146;59524.40475595189;67051.66474167598;67602.9859552117;68231.3176868225;8743.693970710994;9172.403793753385;9302;9385.718428447157;9485.857712134186;13984.580462586138;14279.785803212751;14351.497697580535;14378.352974116398;14427.206503642401;8302.750917472486;11652.184347095623;11769.705757356134;11919.940400297943;12538.996880249375;12568.120231584067;12605.24368537854;12714.173578717353;12783.29691866919;12945;12401.93799030999;12612.747745045232;12793.29636869981;13036.804447933479;13047.673808154872;9010.864837027319;9053.77365565866;9172.174504294646;9177.357584968988;9207.493587852732;9399.154076133182;11602.941985290357;12553.686157846127;12864.421101050288;13270.071095023255 03:44:03 INFO - PROCESS | 10679 | |3;mootools.html;1562.9137749264266;1621.8459246371594;1816.5640246340881;1909.3985394600709;1935.5257961799362;8605.741827745162;9206.309526785484;9472.147506724394;10124.139448146907;10159.695209143729;9478.099580539838;9581.37721048133;9587.952060239706;9608.951955240214;9690.709278721632;2356.045801450411;2370.845895016827;2375.3824005758456;2375.524895020994;2394.5330660521204;2371.845830021052;2400.927972160838;2417.8791060446906;2419.177479656916;2423.745506721795;2398.5442765874427;2405.0980882169188;2426.065964603623;2426.4904370082218;2432.9391765205833;2334.2763743239652;2342.461233916209;2357.9882100589475;2372.92881213563;2374.8931298091543;2334.1130370459286;2354.5526349993447;2357.446000189954;2358.50471401006;2367.443650742074;9577.760555986086;9629;9659.420434773936;9661.613535458644;9664.516774161335;5553.888922221573;5589.357223919261;5669.433056694339;5678.148277758328;5691;3518.313928783888;3572.214112895159;3608.5308909841815;3619.6380361963857;3646.398344273192;1144.5593446523064;1146.1461211397561;1147.168302980341;1187.9465424055938;1192.3680449361852;14205.431782728678;14325;14361.928190358982;14453.205073720941;14501.05743126704;4760.714357138513;4783.278019912828;4832.855014349575;4833.492483289204;4950;11029.338239705643;11128.387938663289;11155.665330040112;11170.329780213213;11184.44077796107;5633.155026745939;5708.800191993343;5713.114467257582;5787.971060144672;5792.044312688444;4638.141943740419;5190.455002224712;5237.5548078413;5345.438728933484;5359.383670877821;4123.711340206157;4154.293770059097;4188.078622703;4203.348480985452;4211.684123690736;1171.630936255094;1173.342927960345;1206.7767463019195;1207.1730864357944;1226.6197478781605;1030.443560477334;1104.3705088099707;1112.6328311657135;1119.44027986007;1121.6803211084803;6649.434798042221;6713.530052896251;6851.760188393382;6878.621675807879;6879.071325371111;466.5870704426607;476.3759475087646;477.0911413756799;479.8560431870425;498.31730529175263;4565.634749220121;4614.792334344963;4615.284630882219;4650.86047418578;4670.859874203779;11959;12462.563810266598;12473.688157796129;12933.482660693655;12936.482540698455;12739.745205095845;12764.042696797776;12783.360831958365;12814.743705126031;12842.614721558368;9231.861522077174;9419.246460283299;9470.337076404585;9482.19401350893;9493.382930109521;6475.643839588868;6732.42774364165;6787.355201255873;6791.558548694319;6912.516123871281;11378.43107844621;11526.769464610828;11607.825882611936;11832;11856;11842;11907.345096019802;11933.582324618597;11963.102767292314;12067.094967877269;8412.831743365221;8640.092790257184;8672.566371681516;8799.34004949644;8947.59735811877;9747.610095596097;9783.755406114904;9802.803943921224;9811.901880981384;9826.213902887608;8425.4944703318;8660.48037117775;8681.175288347597;8751.081136480578;8786.209241168326;8544.444611100258;8562.443441176303;8603;8628.78428039304;8796.428232165144;7744.186860379579;7835.804104897423;7897.921020789719;7906;7929.920700793149;5715.9142612860005;5749.597528172988;5789.4447745690595;5859.326177489473;5961.850953726192;5840.328362238397;5895.587308888336;5901.5868889177345;5936.792212272722;5988.221531200916 03:44:03 INFO - PROCESS | 10679 | |4;prototype.html;326.72555053754843;344.0658611868777;348.7593560443293;349.2160100574211;351.1344535719452;5657.603967722261;5724.427557244274;5828.562857785667;5912.88174236515;5980.282366116066;5715.199872017921;5753.683547404891;5778.162166485857;5831.737571809268;5843.590948633598;4541.205289074399;4542.364069030338;4542.454905411347;4543.363929049936;4572.154151481986;4443.266860967952;4456.777161141946;4491.191585514606;4499.122671079141;4568.703034302776;4427.114577084596;4446.310402047217;4454.53227411122;4504.806226350003;4511.796969136397;4495.685302028843;4512.932306015412;4513.2101882170655;4534.478534968455;4547.931781023287;3879.86420475282;3978.6419222269847;3981.7013723970526;4028.637422631977;4040.878773636796;5543.77824887004;5556.361018482886;5567.749451274703;5593.937151941118;5595.272614560122;5233.110371236899;5237.633365664405;5255.605829562798;5268.367795864521;5280.973595132;5927.496162826165;6066.726997285133;6069.635821850659;6072.692376896751;6153.507719382439;4413.360062790909;4415.558444155591;4439.289713645833;4445.755483448409;4462.620677242438;6223.386177805332;6281.24625044993;6304.810855674337;6330.9683451582905;6345.9365406345805;4386.8025938832825;4483.932741008887;4488.326750987313;4490;4521.163584736834;4540.114677637895;4579.74811385377;4590.196715574761;4591.1965406053805;4592.2193227151465;5138.563222126161;5144.536991670768;5160.354955630546;5201.843944681666;5206;5912.556558258148;5921.437463440966;6067.908981365283;6077.301110372364;6078.756849725962;1500.5123334916195;1516.5905205594647;1519.9056679190965;1522.7639715844061;1534.9539513814605;908.4594666173616;947.6114792934864;952.1145334838667;983.3706427886159;1003.7791685829106;5212.218167274939;5290.376092376734;5321.281626980385;5365.061114304981;5367.1680889462195;5591.84713885149;5596.300462442195;5598.860028499239;5614.803481878114;5650.660960342392;5072.17401735375;5243.8164664236565;5251.76367063483;5305.65513241638;5385.353757549119;2956.763458923324;2973.8067025643695;2974.8363839988574;2997.531209707228;3054.5265483849594;5634.352049514277;5665.291838520185;5666.46168613981;5756.827295181151;5773.364929857712;5906.763729450774;6350.523710721714;6394.520410969103;6420.844248035399;6435.581687190318;6445.4199122079235;6451.548391612542;6458.257300410513;6472.546921715435;6508.284088750233;6071.574989750675;6199.256089269136;6320.367963203643;6328.6519241442165;6330.873382532415;6175.722092505938;6207.565470417027;6251.468625166912;6256.280527739186;6297.338779428277;6266.592671476339;6297.392361422515;6409;6469.285639305682;6471.546991710723;4322.092360604308;4395.296752519709;4400.427944367212;4410.823567057282;4417.77911104437;6062.7271772769445;6096.451319381277;6288.27684816252;6340.112384266298;6372.490200784019;6123.908141377794;6151.630902145886;6151.876962460815;6156;6169.383061693795;6115.84710382244;6127.172831667668;6127.417895299939;6148.047052706837;6167.475764560063;5877.0302900021015;6049.848753781191;6102.298235702773;6136.509079273558;6139.631622102688;6171.413715697002;6191.721372538156;6194.535409844189;6200.286966998672;6204.348543403058;5927.644341339534;6029.306629737636;6054.39456054391;6070.025687413224;6102.298235702951 03:44:03 INFO - PROCESS | 10679 | |5;yui.html;779.7231982646164;801.9839603207932;824.4229039672227;881.6209030117049;917.7060344913671;15763.369465221393;16068;16961;17163.399281025166;17200.569985750364;15243.237838108078;15282.69434611307;15380.615484612863;15405.460808871663;15437;848.503625379154;865.9913400865973;866.2593482572373;870.4646642314995;882.8322618702458;870.8301881133182;876.3646356391629;881.3918396306528;881.5812489067673;882.7307671160294;925.9907400926005;929.6792606550763;929.7443203119128;929.9628014879397;931.4504442378995;921.760342311004;923.5659240157182;925.3846192282158;925.6575067225136;927.0636656976469;672.0490505934098;675.0751470485467;679.1815861886415;679.3681875855452;680.0275605883585;16468.752968705478;16476.258568364454;16552.66894662112;16606.169691515377;16645.750313745302;13407.262600556965;13509.932450337783;13612.863871361258;14067.155970641794;15631.531054068397;13959;13973.371198296101;14129.293535323295;14138.50515231962;14145.080569762933;4725.57101065023;4730.692504987199;4748.335233067373;4821.300911367832;4864.124457597631;73693.63153184253;76932.61533692351;77698.61150694267;78375.21624783793;78393.21606783917;11747.177697561088;11761.941190294165;11903.940480297542;11948.462319195656;12055.21641093326;20622.484437888874;20735.377938661863;20779.480512986993;20797.58404831895;20861.269855554983;8552.230299273095;8577.01364343096;8630.395872289006;8667.263282620921;9001;4814.1398507127205;4853.102176097434;4953.356063711694;5082.923756143661;5115.2071428928575;3675.9816200918826;3760.2291530236234;3778.678812300985;3802.467654528313;3808.7524310919703;680.425040840489;680.43863812355;686.4474098350776;688.1260798785514;697.5326531224092;668.9732410703517;669.2103318084706;671.1912145864222;707.7443758709995;714.1109318898006;8954.86567701485;9104.772380690403;9125.406848554823;9323.813523729623;9507.429554226768;616.0236025899001;619.7335145887222;715.141829804237;718.2458418660385;729.9270072992658;4564.543545645475;4587.977060114678;4598.678092533491;4604.97697511517;4686.390769199982;79576;94205;97203.51398243105;98886;118763;82076;84439;88279;93943.53028234815;97644.51177744065;88499.55750221208;92065.23804285882;92266.53866730623;92647;94710.5264473687;10523.579056837641;10574.735631609272;10678.346989101667;10691.198160137865;10826.56693732242;51212.23181652353;51470;52758;53742.46257537531;54460.45539544554;66879;68414.3158568408;72156.27843721706;74810;78767.60616196883;14176.220307882753;14319.355628996513;14388.136711797326;14620.195889226196;15037.924810375878;15337.233138343261;15705;15721.213939302761;15944.681106378039;16271;14706.77939830882;14774;14872.107673539622;14971.775423368876;15314.846851531342;14356.49752258666;14424.278786060864;14611.70776584441;14696.77954830657;14739;14481.927590362402;14501.419943202576;14622.268886555843;14685.632859178606;15004.624884377978;11949.402529873298;12026.819597705866;12027.218230815319;12165.69585760363;12778.87221127814;11986.700332491757;12021.196820476998;12448.813267801172;12686.619401417973;12974.935125324313 03:44:03 INFO - PROCESS | 10679 | __end_tp_report 03:44:03 INFO - PROCESS | 10679 | __start_cc_report 03:44:03 INFO - PROCESS | 10679 | _x_x_mozilla_cycle_collect,356 03:44:03 INFO - PROCESS | 10679 | __end_cc_report 03:44:03 INFO - PROCESS | 10679 | __startTimestamp1466592243758__endTimestamp 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | ------- Summary: start ------- 03:44:03 INFO - PROCESS | 10679 | Number of tests: 6 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | [#0] dojo.html Cycles:165 Average:5739.15 Median:5985.25 stddev:648.80 (10.8%) stddev-sans-first:625.30 03:44:03 INFO - PROCESS | 10679 | Values: 3443.5 3466.7 3486.1 3496.4 3498.0 5689.1 5719.3 5743.8 5773.7 5807.8 5743.8 5839.0 5845.6 5853.6 5872.3 5225.5 5228.3 5267.4 5283.3 5314.1 5094.5 5104.8 5181.8 5257.3 5281.8 5193.9 5210.7 5216.8 5228.4 5258.8 5217.3 5262.5 5272.4 5280.7 5317.5 4947.0 4997.9 5156.3 5184.6 5253.3 5508.8 5583.6 5586.7 5627.1 5638.2 6109.2 6140.1 6148.0 6148.5 6174.6 6007.5 6094.2 6136.7 6197.2 6208.8 5737.3 5749.9 5772.4 5776.7 5807.4 6311.2 6316.7 6322.4 6327.8 6335.1 5872.9 5976.8 6028.0 6050.1 6076.2 6167.7 6193.0 6198.5 6203.0 6206.6 6089.9 6106.4 6159.2 6179.7 6221.1 5960.1 6072.5 6103.6 6140.0 6192.9 4698.5 4699.7 4722.6 4731.2 4741.1 4121.4 4180.2 4205.3 4208.1 4241.5 5699.8 5867.7 5871.0 5935.0 5956.5 6237.1 6237.6 6309.4 6338.7 6372.4 5775.6 6036.7 6054.5 6082.7 6084.9 5294.0 5356.9 5365.6 5396.4 5414.3 6474.9 6488.7 6525.9 6529.1 6530.1 5892.4 6073.4 6270.7 6325.8 6326.4 6263.8 6341.1 6350.6 6353.4 6356.7 6029.5 6076.7 6088.0 6092.2 6127.7 5985.3 6119.1 6130.0 6183.5 6210.7 6118.2 6120.6 6132.5 6138.9 6142.3 6106.2 6123.3 6128.0 6133.4 6139.7 5804.2 5851.5 5877.9 5917.5 6030.1 6051.2 6096.5 6103.7 6112.2 6122.8 5926.0 5961.5 5978.6 5990.5 5991.0 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | [#1] ext.html Cycles:180 Average:67273.78 Median:43746.63 stddev:142726.50 (326.3%) stddev-sans-first:143039.05 03:44:03 INFO - PROCESS | 10679 | Values: 585.8 618.0 639.1 644.2 684.3 39546.0 44087.8 44293.0 44401.3 44491.6 43772.0 44491.1 45036.8 45168.8 45172.0 8799.2 8870.8 8932.9 8933.6 8952.4 8850.9 8892.2 8913.5 8942.6 8948.5 8987.6 9003.0 9014.2 9028.4 9057.0 8950.4 8963.1 8970.0 8993.7 9005.1 8752.1 8802.7 8806.3 8843.0 8876.8 42773.6 43047.4 43112.1 43345.1 43395.8 3693.4 3805.1 3805.9 3889.3 4162.4 33340.0 33601.0 34073.7 36174.0 36461.0 4604.6 4607.2 4702.0 4787.9 4908.8 359912.0 361990.0 362407.0 363474.0 363778.0 65254.0 65415.3 66207.3 66419.7 66527.0 38460.2 39485.6 39579.4 41628.4 41652.6 15565.6 15723.8 15742.2 15744.1 15778.1 12728.8 12824.6 12850.4 12861.7 12897.0 21053.5 21058.7 21235.9 21310.6 21330.7 7660.5 7667.3 7679.0 7849.6 7950.6 973.4 1044.7 1055.6 1089.2 1095.3 33170.0 33358.8 33532.5 33648.0 33673.5 1128.3 1154.5 1216.3 1218.6 1220.4 17180.7 17234.5 17356.0 17601.0 17808.7 549035.0 561642.0 565632.0 571620.0 894521.0 62624.7 62844.4 62914.1 62963.0 63259.0 1454.3 1499.5 1512.3 1516.9 1521.3 32928.0 33481.8 33652.8 34118.7 34606.0 53248.5 53840.0 53886.7 53900.0 53903.2 555488.0 558198.0 560407.0 560497.0 561088.0 30165.4 31410.4 31428.1 31456.8 31459.8 50322.2 50890.2 51392.2 51414.2 51613.2 41284.0 42936.1 43932.3 47535.8 47945.8 43583.0 44051.8 44592.8 45136.5 45650.8 42765.0 43589.0 43721.3 43839.3 44870.3 37819.0 38216.8 38364.8 39036.0 39112.8 29243.0 29314.4 29390.6 29705.7 29812.3 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | [#2] jquery.html Cycles:180 Average:29512.39 Median:20103.00 stddev:80940.21 (402.6%) stddev-sans-first:81137.80 03:44:03 INFO - PROCESS | 10679 | Values: 424.2 437.1 438.6 438.7 444.8 18072.7 19105.3 19884.2 19895.7 19926.0 17027.1 18074.7 19928.0 20100.9 20105.1 4855.8 5173.4 5184.5 5226.6 5235.2 5104.2 5136.4 5149.6 5344.1 5397.2 5310.2 5363.6 5373.8 5407.6 5411.8 5297.8 5387.4 5486.3 5776.9 5783.2 5471.9 5645.6 5693.3 5721.2 5749.7 13671.7 13695.9 13720.6 14407.2 23276.2 2294.3 2343.2 2408.2 2423.4 2567.2 9768.5 9935.3 10268.6 10433.1 10553.4 1695.1 1751.4 1871.4 1930.6 1937.9 83918.6 84849.6 85833.0 86578.6 86981.0 11409.5 11661.4 11828.0 12015.8 12299.8 16909.9 16935.9 17000.1 17026.4 17028.0 8518.6 8581.1 8632.5 8661.7 8767.5 8242.7 8252.8 8292.8 8386.6 8453.9 4943.4 5054.9 5063.7 5113.5 5214.5 1859.1 1896.0 1933.4 1939.9 1943.8 1010.4 1056.3 1064.4 1091.1 1110.3 19232.2 19503.9 20024.7 20029.3 20566.7 1018.2 1022.4 1035.5 1053.5 1101.8 10999.6 11209.1 11227.4 11297.2 11339.8 467686.0 488527.0 491400.0 494480.0 503493.0 84253.0 93293.0 101143.0 102213.0 104368.0 1080.0 1115.2 1116.1 1122.6 1137.7 18726.1 18994.5 19028.5 19051.1 19164.5 39648.2 41509.4 44413.1 45755.0 46117.1 56503.4 59524.4 67051.7 67603.0 68231.3 8743.7 9172.4 9302.0 9385.7 9485.9 13984.6 14279.8 14351.5 14378.4 14427.2 8302.8 11652.2 11769.7 11919.9 12539.0 12568.1 12605.2 12714.2 12783.3 12945.0 12401.9 12612.7 12793.3 13036.8 13047.7 9010.9 9053.8 9172.2 9177.4 9207.5 9399.2 11602.9 12553.7 12864.4 13270.1 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | [#3] mootools.html Cycles:180 Average:6468.06 Median:4644.50 stddev:3860.47 (83.1%) stddev-sans-first:3853.70 03:44:03 INFO - PROCESS | 10679 | Values: 1562.9 1621.8 1816.6 1909.4 1935.5 8605.7 9206.3 9472.1 10124.1 10159.7 9478.1 9581.4 9588.0 9609.0 9690.7 2356.0 2370.8 2375.4 2375.5 2394.5 2371.8 2400.9 2417.9 2419.2 2423.7 2398.5 2405.1 2426.1 2426.5 2432.9 2334.3 2342.5 2358.0 2372.9 2374.9 2334.1 2354.6 2357.4 2358.5 2367.4 9577.8 9629.0 9659.4 9661.6 9664.5 5553.9 5589.4 5669.4 5678.1 5691.0 3518.3 3572.2 3608.5 3619.6 3646.4 1144.6 1146.1 1147.2 1187.9 1192.4 14205.4 14325.0 14361.9 14453.2 14501.1 4760.7 4783.3 4832.9 4833.5 4950.0 11029.3 11128.4 11155.7 11170.3 11184.4 5633.2 5708.8 5713.1 5788.0 5792.0 4638.1 5190.5 5237.6 5345.4 5359.4 4123.7 4154.3 4188.1 4203.3 4211.7 1171.6 1173.3 1206.8 1207.2 1226.6 1030.4 1104.4 1112.6 1119.4 1121.7 6649.4 6713.5 6851.8 6878.6 6879.1 466.6 476.4 477.1 479.9 498.3 4565.6 4614.8 4615.3 4650.9 4670.9 11959.0 12462.6 12473.7 12933.5 12936.5 12739.7 12764.0 12783.4 12814.7 12842.6 9231.9 9419.2 9470.3 9482.2 9493.4 6475.6 6732.4 6787.4 6791.6 6912.5 11378.4 11526.8 11607.8 11832.0 11856.0 11842.0 11907.3 11933.6 11963.1 12067.1 8412.8 8640.1 8672.6 8799.3 8947.6 9747.6 9783.8 9802.8 9811.9 9826.2 8425.5 8660.5 8681.2 8751.1 8786.2 8544.4 8562.4 8603.0 8628.8 8796.4 7744.2 7835.8 7897.9 7906.0 7929.9 5715.9 5749.6 5789.4 5859.3 5961.9 5840.3 5895.6 5901.6 5936.8 5988.2 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | [#4] prototype.html Cycles:180 Average:5055.38 Median:5642.51 stddev:1499.77 (26.6%) stddev-sans-first:1461.38 03:44:03 INFO - PROCESS | 10679 | Values: 326.7 344.1 348.8 349.2 351.1 5657.6 5724.4 5828.6 5912.9 5980.3 5715.2 5753.7 5778.2 5831.7 5843.6 4541.2 4542.4 4542.5 4543.4 4572.2 4443.3 4456.8 4491.2 4499.1 4568.7 4427.1 4446.3 4454.5 4504.8 4511.8 4495.7 4512.9 4513.2 4534.5 4547.9 3879.9 3978.6 3981.7 4028.6 4040.9 5543.8 5556.4 5567.7 5593.9 5595.3 5233.1 5237.6 5255.6 5268.4 5281.0 5927.5 6066.7 6069.6 6072.7 6153.5 4413.4 4415.6 4439.3 4445.8 4462.6 6223.4 6281.2 6304.8 6331.0 6345.9 4386.8 4483.9 4488.3 4490.0 4521.2 4540.1 4579.7 4590.2 4591.2 4592.2 5138.6 5144.5 5160.4 5201.8 5206.0 5912.6 5921.4 6067.9 6077.3 6078.8 1500.5 1516.6 1519.9 1522.8 1535.0 908.5 947.6 952.1 983.4 1003.8 5212.2 5290.4 5321.3 5365.1 5367.2 5591.8 5596.3 5598.9 5614.8 5650.7 5072.2 5243.8 5251.8 5305.7 5385.4 2956.8 2973.8 2974.8 2997.5 3054.5 5634.4 5665.3 5666.5 5756.8 5773.4 5906.8 6350.5 6394.5 6420.8 6435.6 6445.4 6451.5 6458.3 6472.5 6508.3 6071.6 6199.3 6320.4 6328.7 6330.9 6175.7 6207.6 6251.5 6256.3 6297.3 6266.6 6297.4 6409.0 6469.3 6471.5 4322.1 4395.3 4400.4 4410.8 4417.8 6062.7 6096.5 6288.3 6340.1 6372.5 6123.9 6151.6 6151.9 6156.0 6169.4 6115.8 6127.2 6127.4 6148.0 6167.5 5877.0 6049.8 6102.3 6136.5 6139.6 6171.4 6191.7 6194.5 6200.3 6204.3 5927.6 6029.3 6054.4 6070.0 6102.3 03:44:03 INFO - PROCESS | 10679 | 03:44:03 INFO - PROCESS | 10679 | [#5] yui.html Cycles:180 Average:20644.05 Median:4837.20 stddev:28127.62 (581.5%) stddev-sans-first:28166.97 03:44:03 INFO - PROCESS | 10679 | Values: 779.7 802.0 824.4 881.6 917.7 15763.4 16068.0 16961.0 17163.4 17200.6 15243.2 15282.7 15380.6 15405.5 15437.0 848.5 866.0 866.3 870.5 882.8 870.8 876.4 881.4 881.6 882.7 926.0 929.7 929.7 930.0 931.5 921.8 923.6 925.4 925.7 927.1 672.0 675.1 679.2 679.4 680.0 16468.8 16476.3 16552.7 16606.2 16645.8 13407.3 13509.9 13612.9 14067.2 15631.5 13959.0 13973.4 14129.3 14138.5 14145.1 4725.6 4730.7 4748.3 4821.3 4864.1 73693.6 76932.6 77698.6 78375.2 78393.2 11747.2 11761.9 11903.9 11948.5 12055.2 20622.5 20735.4 20779.5 20797.6 20861.3 8552.2 8577.0 8630.4 8667.3 9001.0 4814.1 4853.1 4953.4 5082.9 5115.2 3676.0 3760.2 3778.7 3802.5 3808.8 680.4 680.4 686.4 688.1 697.5 669.0 669.2 671.2 707.7 714.1 8954.9 9104.8 9125.4 9323.8 9507.4 616.0 619.7 715.1 718.2 729.9 4564.5 4588.0 4598.7 4605.0 4686.4 79576.0 94205.0 97203.5 98886.0 118763.0 82076.0 84439.0 88279.0 93943.5 97644.5 88499.6 92065.2 92266.5 92647.0 94710.5 10523.6 10574.7 10678.3 10691.2 10826.6 51212.2 51470.0 52758.0 53742.5 54460.5 66879.0 68414.3 72156.3 74810.0 78767.6 14176.2 14319.4 14388.1 14620.2 15037.9 15337.2 15705.0 15721.2 15944.7 16271.0 14706.8 14774.0 14872.1 14971.8 15314.8 14356.5 14424.3 14611.7 14696.8 14739.0 14481.9 14501.4 14622.3 14685.6 15004.6 11949.4 12026.8 12027.2 12165.7 12778.9 11986.7 12021.2 12448.8 12686.6 12974.9 03:44:03 INFO - PROCESS | 10679 | -------- Summary: end -------- 03:44:03 INFO - PROCESS | 10679 | 03:44:04 INFO - TEST-INFO | 10679: exit 0 03:44:04 INFO - TEST-OK | dromaeo_css | took 1110232ms 03:44:04 INFO - TEST-START | kraken 03:44:04 INFO - operating with platform_type : linux_ 03:44:04 INFO - Initialising browser for kraken test... 03:44:04 INFO - TEST-INFO | started process 10926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEBDb1L/profile http://localhost:40296/getInfo.html) 03:44:09 INFO - PROCESS | 10926 | __metrics Screen width/height:1600/1200 03:44:09 INFO - PROCESS | 10926 | colorDepth:24 03:44:09 INFO - PROCESS | 10926 | Browser inner width/height: 1024/697 03:44:09 INFO - PROCESS | 10926 | __metrics 03:44:09 ERROR - PROCESS | 10926 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:44:10 INFO - TEST-INFO | 10926: exit 0 03:44:10 INFO - Browser initialized. 03:44:10 INFO - Running cycle 1/1 for kraken test... 03:44:10 INFO - TEST-INFO | started process 11056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEBDb1L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:22 INFO - PROCESS | 11056 | RSS: Main: 156282880 03:44:22 INFO - PROCESS | 11056 | 03:44:25 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40296/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:25 INFO - PROCESS | 11056 | RSS: Main: 161910784 03:44:25 INFO - PROCESS | 11056 | 03:44:28 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40296/tests/kraken/driver.html?testName=audio-dft) 03:44:29 INFO - PROCESS | 11056 | RSS: Main: 160526336 03:44:29 INFO - PROCESS | 11056 | 03:44:32 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40296/tests/kraken/driver.html?testName=audio-fft) 03:44:32 INFO - PROCESS | 11056 | RSS: Main: 162127872 03:44:32 INFO - PROCESS | 11056 | 03:44:34 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40296/tests/kraken/driver.html?testName=audio-oscillator) 03:44:35 INFO - PROCESS | 11056 | RSS: Main: 161030144 03:44:35 INFO - PROCESS | 11056 | 03:44:37 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:38 INFO - PROCESS | 11056 | RSS: Main: 160948224 03:44:38 INFO - PROCESS | 11056 | 03:44:41 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40296/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:41 INFO - PROCESS | 11056 | RSS: Main: 160608256 03:44:41 INFO - PROCESS | 11056 | 03:44:45 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40296/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:45 INFO - PROCESS | 11056 | RSS: Main: 161705984 03:44:45 INFO - PROCESS | 11056 | 03:44:48 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40296/tests/kraken/driver.html?testName=json-parse-financial) 03:44:49 INFO - PROCESS | 11056 | RSS: Main: 161685504 03:44:49 INFO - PROCESS | 11056 | 03:44:50 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:51 INFO - PROCESS | 11056 | RSS: Main: 161099776 03:44:51 INFO - PROCESS | 11056 | 03:44:53 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:53 INFO - PROCESS | 11056 | RSS: Main: 161243136 03:44:53 INFO - PROCESS | 11056 | 03:44:56 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:56 INFO - PROCESS | 11056 | RSS: Main: 161513472 03:44:56 INFO - PROCESS | 11056 | 03:44:59 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:59 INFO - PROCESS | 11056 | RSS: Main: 161869824 03:44:59 INFO - PROCESS | 11056 | 03:45:02 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:03 INFO - PROCESS | 11056 | RSS: Main: 161366016 03:45:03 INFO - PROCESS | 11056 | 03:45:04 INFO - PROCESS | 11056 | Cycle 1(1): loaded http://localhost:40296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40296/tests/kraken/driver.html?testName=ai-astar) 03:45:05 INFO - PROCESS | 11056 | RSS: Main: 162496512 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | __start_tp_report 03:45:05 INFO - PROCESS | 11056 | _x_x_mozilla_page_load 03:45:05 INFO - PROCESS | 11056 | _x_x_mozilla_page_load_details 03:45:05 INFO - PROCESS | 11056 | |i|pagename|runs| 03:45:05 INFO - PROCESS | 11056 | |0;ai-astar;112;107;113;113;113;112;111;113;111;114 03:45:05 INFO - PROCESS | 11056 | |1;audio-beat-detection;149;132;154;184;127;157;157;126;193;125 03:45:05 INFO - PROCESS | 11056 | |2;audio-dft;162;161;162;163;162;166;163;172;162;163 03:45:05 INFO - PROCESS | 11056 | |3;audio-fft;73;76;77;175;75;80;76;76;179;76 03:45:05 INFO - PROCESS | 11056 | |4;audio-oscillator;85;85;140;87;85;85;139;85;84;144 03:45:05 INFO - PROCESS | 11056 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;118;117;117 03:45:05 INFO - PROCESS | 11056 | |6;imaging-darkroom;146;147;146;146;149;147;147;151;147;147 03:45:05 INFO - PROCESS | 11056 | |7;imaging-desaturate;96;96;97;96;95;96;96;96;95;95 03:45:05 INFO - PROCESS | 11056 | |8;json-parse-financial;52;53;52;52;54;60;52;53;53;54 03:45:05 INFO - PROCESS | 11056 | |9;json-stringify-tinderbox;61;61;60;61;61;61;61;62;61;61 03:45:05 INFO - PROCESS | 11056 | |10;stanford-crypto-aes;78;92;76;82;81;78;78;81;101;79 03:45:05 INFO - PROCESS | 11056 | |11;stanford-crypto-ccm;122;125;132;125;120;118;119;119;130;130 03:45:05 INFO - PROCESS | 11056 | |12;stanford-crypto-pbkdf2;157;159;155;156;159;158;157;154;160;157 03:45:05 INFO - PROCESS | 11056 | |13;stanford-crypto-sha256-iterative;63;64;62;62;63;60;61;61;60;61 03:45:05 INFO - PROCESS | 11056 | __end_tp_report 03:45:05 INFO - PROCESS | 11056 | __start_cc_report 03:45:05 INFO - PROCESS | 11056 | _x_x_mozilla_cycle_collect,851 03:45:05 INFO - PROCESS | 11056 | __end_cc_report 03:45:05 INFO - PROCESS | 11056 | __startTimestamp1466592305031__endTimestamp 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | ------- Summary: start ------- 03:45:05 INFO - PROCESS | 11056 | Number of tests: 14 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:1.97 (1.7%) stddev-sans-first:2.09 03:45:05 INFO - PROCESS | 11056 | Values: 112.0 107.0 113.0 113.0 113.0 112.0 111.0 113.0 111.0 114.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:155.50 stddev:23.97 (15.4%) stddev-sans-first:25.42 03:45:05 INFO - PROCESS | 11056 | Values: 149.0 132.0 154.0 184.0 127.0 157.0 157.0 126.0 193.0 125.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.24 (2.0%) stddev-sans-first:3.38 03:45:05 INFO - PROCESS | 11056 | Values: 162.0 161.0 162.0 163.0 162.0 166.0 163.0 172.0 162.0 163.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.00 stddev:42.58 (56.0%) stddev-sans-first:44.32 03:45:05 INFO - PROCESS | 11056 | Values: 73.0 76.0 77.0 175.0 75.0 80.0 76.0 76.0 179.0 76.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:85.00 stddev:27.02 (31.8%) stddev-sans-first:27.96 03:45:05 INFO - PROCESS | 11056 | Values: 85.0 85.0 140.0 87.0 85.0 85.0 139.0 85.0 84.0 144.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:45:05 INFO - PROCESS | 11056 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 117.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.57 (1.1%) stddev-sans-first:1.59 03:45:05 INFO - PROCESS | 11056 | Values: 146.0 147.0 146.0 146.0 149.0 147.0 147.0 151.0 147.0 147.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:45:05 INFO - PROCESS | 11056 | Values: 96.0 96.0 97.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:2.42 (4.6%) stddev-sans-first:2.50 03:45:05 INFO - PROCESS | 11056 | Values: 52.0 53.0 52.0 52.0 54.0 60.0 52.0 53.0 53.0 54.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 03:45:05 INFO - PROCESS | 11056 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:80.00 stddev:7.83 (9.8%) stddev-sans-first:8.13 03:45:05 INFO - PROCESS | 11056 | Values: 78.0 92.0 76.0 82.0 81.0 78.0 78.0 81.0 101.0 79.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:125.00 stddev:5.21 (4.2%) stddev-sans-first:5.47 03:45:05 INFO - PROCESS | 11056 | Values: 122.0 125.0 132.0 125.0 120.0 118.0 119.0 119.0 130.0 130.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.50 stddev:1.87 (1.2%) stddev-sans-first:1.99 03:45:05 INFO - PROCESS | 11056 | Values: 157.0 159.0 155.0 156.0 159.0 158.0 157.0 154.0 160.0 157.0 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - PROCESS | 11056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.33 03:45:05 INFO - PROCESS | 11056 | Values: 63.0 64.0 62.0 62.0 63.0 60.0 61.0 61.0 60.0 61.0 03:45:05 INFO - PROCESS | 11056 | -------- Summary: end -------- 03:45:05 INFO - PROCESS | 11056 | 03:45:05 INFO - TEST-INFO | 11056: exit 0 03:45:05 INFO - TEST-OK | kraken | took 61547ms 03:45:05 INFO - SUITE-END | took 1171s 03:45:06 INFO - Completed test suite (00:19:32) 03:45:06 INFO - javascript benchmark 03:45:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7668.587911071736, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3443.5006923996016, 3466.7053300469443, 3486.0587641336824, 3496.440569508879, 3498.038039539126, 5689.061304884694, 5719.256496655435, 5743.770249190027, 5773.711314434283, 5807.796727114546, 5743.770249190027, 5839.0, 5845.56158288128, 5853.560982926287, 5872.324682661495, 5225.451327610604, 5228.29418028566, 5267.394249661281, 5283.339582552181, 5314.1497360422145, 5094.541491265785, 5104.795808167669, 5181.766820493068, 5257.290265814124, 5281.815136470224, 5193.870153246161, 5210.687358758468, 5216.76524556394, 5228.424873263957, 5258.842234732964, 5217.269582258468, 5262.500062494057, 5272.420033796279, 5280.656757310801, 5317.548008419289, 4946.96113816099, 4997.90004199914, 5156.303898973628, 5184.585233181337, 5253.343332083489, 5508.834734957958, 5583.637063590853, 5586.664800112007, 5627.127795191711, 5638.182463542763, 6109.205803245594, 6140.109684095826, 6148.0, 6148.477379422754, 6174.598651087665, 6007.4893634041155, 6094.177286066369, 6136.723847426876, 6197.225346831646, 6208.751649933997, 5737.340205876378, 5749.942500574983, 5772.422757724236, 5776.711164441803, 5807.361190269067, 6311.2426508819235, 6316.715747791361, 6322.36776322364, 6327.810165695037, 6335.144755458046, 5872.941270587239, 5976.760929562855, 6027.969860150672, 6050.092486127028, 6076.240469941257, 6167.691615419211, 6193.0, 6198.504119670415, 6202.968985155136, 6206.565540412128, 6089.878202435926, 6106.358832322631, 6159.168512250879, 6179.6910154493, 6221.06683997395, 5960.135780311917, 6072.453479186806, 6103.6032657877095, 6139.969300153471, 6192.907106393408, 4698.506656801055, 4699.671023028423, 4722.574968252805, 4731.219348807408, 4741.146593613183, 4121.443605113332, 4180.184863951561, 4205.306124489425, 4208.095259519218, 4241.491021077491, 5699.772009119672, 5867.735951882176, 5870.970645146747, 5935.0207215808905, 5956.493698035629, 6237.064440333896, 6237.625742455467, 6309.432151106423, 6338.7464501420345, 6372.394622510854, 5775.595708300379, 6036.667983260875, 6054.455099041019, 6082.665453400017, 6084.908726369108, 5293.973530132324, 5356.91964620531, 5365.570754339644, 5396.4333744957, 5414.269073675004, 6474.902876456857, 6488.708008139645, 6525.902111468332, 6529.053287273318, 6530.05314229434, 5892.440218179266, 6073.392660733891, 6270.686465676789, 6325.810225693236, 6326.398992095744, 6263.812085637438, 6341.0805433212845, 6350.618962862243, 6353.396427339396, 6356.713947872265, 6029.4874935629205, 6076.665783381956, 6088.025915853619, 6092.208012958465, 6127.662978536223, 5985.25184351956, 6119.136988620051, 6130.0006981778415, 6183.536234782499, 6210.720517576629, 6118.223266370627, 6120.632762034292, 6132.544012458836, 6138.907916381348, 6142.262928448615, 6106.175666284995, 6123.2958209804665, 6128.0, 6133.417325354084, 6139.723712432862, 5804.1874137619925, 5851.502622276984, 5877.941220587911, 5917.497012753965, 6030.095485677183, 6051.1830902829315, 6096.451319381277, 6103.664298463627, 6112.235970503687, 6122.755089796537, 5925.970370148121, 5961.463468287875, 5978.611390259619, 5990.460858522754, 5991.0], "value": 5696.53117333274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.8213244960285, 618.0111821086261, 639.0892977507053, 644.2333622988643, 684.3327755438445, 39546.0, 44087.77956110219, 44293.0, 44401.333979990326, 44491.55508444919, 43772.0, 44491.11017779651, 45036.77481612596, 45168.77415612926, 45172.0, 8799.2080712736, 8870.822583548324, 8932.866007009867, 8933.55332233389, 8952.373333866632, 8850.867236991418, 8892.15524525169, 8913.509756963364, 8942.64229430822, 8948.507832069234, 8987.595558199864, 9003.0, 9014.188723014928, 9028.368014239006, 9057.0, 8950.41822281553, 8963.058878817761, 8970.013298537187, 8993.730188094367, 9005.054469280762, 8752.081031491729, 8802.735917922473, 8806.295496360275, 8843.0, 8876.778080547974, 42773.57226427727, 43047.35428968568, 43112.13775724468, 43345.13309733788, 43395.78302108501, 3693.372126738434, 3805.086779173006, 3805.8858234253016, 3889.3193691103943, 4162.375643653446, 33340.0, 33601.0, 34073.659263407295, 36174.0, 36461.0, 4604.608608268301, 4607.216773148572, 4701.952980470186, 4787.928181077286, 4908.754562271908, 359912.0, 361990.0, 362407.0, 363474.0, 363778.0, 65254.0, 65415.34584654093, 66207.33792662012, 66419.66790166018, 66527.0, 38460.23079538393, 39485.60514394877, 39579.406308904814, 41628.37557436641, 41652.58347416487, 15565.610859728371, 15723.764143537855, 15742.212889355487, 15744.134072626115, 15778.13220272896, 12728.80906786399, 12824.551140710031, 12850.42173102194, 12861.678458038437, 12897.0, 21053.47366315824, 21058.684119738216, 21235.893820531106, 21310.573788524143, 21330.680039799416, 7660.463767536219, 7667.348275396542, 7679.0, 7849.646765895548, 7950.562719050507, 973.3867663372031, 1044.7231483656838, 1055.6410820321128, 1089.215764649451, 1095.2552264460085, 33170.0, 33358.83320583381, 33532.49701254483, 33647.99056028323, 33673.49489757656, 1128.2835399521364, 1154.4977934598476, 1216.3188614375802, 1218.5674085699627, 1220.4446976625613, 17180.656386872193, 17234.535064519405, 17356.0, 17601.0, 17808.732869006973, 549035.0, 561642.0, 565632.0, 571620.0, 894521.0, 62624.68687656533, 62844.371556283855, 62914.0562891557, 62963.0, 63259.0, 1454.2873991744182, 1499.452699764578, 1512.3345727879478, 1516.9317380717894, 1521.3230112600008, 32928.0, 33481.83259083689, 33652.831735841166, 34118.65881341254, 34606.0, 53248.46751532435, 53840.0, 53886.73056634849, 53900.0, 53903.19145212903, 555488.0, 558198.0, 560407.0, 560497.0, 561088.0, 30165.396692066475, 31410.371792564478, 31428.057158285286, 31456.842715786275, 31459.84270078635, 50322.2451663218, 50890.23664645107, 51392.229116562536, 51414.22878656898, 51613.22580161376, 41284.0, 42936.14127717491, 43932.341014884165, 47535.762321189555, 47945.76027119842, 43583.0, 44051.77974110109, 44592.77703611461, 45136.54863451324, 45650.77174614106, 42765.0, 43589.0, 43721.25114995365, 43839.34240986324, 44870.3269450952, 37819.0, 38216.80891595524, 38364.80817595894, 39036.0, 39112.80443597764, 29243.0, 29314.41371172522, 29390.55914161332, 29705.702942970292, 29812.254693632833], "value": 21035.401263817323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.1919144030619, 437.13447374199086, 438.6446977947862, 438.67099675243566, 444.7998400719677, 18072.728909066358, 19105.331313404033, 19884.204631814748, 19895.701564476527, 19926.0, 17027.06351150686, 18074.728879066824, 19928.0, 20100.899495502537, 20105.095270712816, 4855.757212139397, 5173.405058418292, 5184.507471790174, 5226.608004399666, 5235.188545775411, 5104.2088476286235, 5136.43499215086, 5149.562287205592, 5344.144936810111, 5397.190421436777, 5310.230016647583, 5363.570914326864, 5373.75818088185, 5407.648502847303, 5411.756470958797, 5297.841064768063, 5387.380451248097, 5486.286782718261, 5776.9422305776825, 5783.248177736909, 5471.863203419906, 5645.633033852787, 5693.316801983747, 5721.199032135504, 5749.683767392792, 13671.658208544766, 13695.863041369657, 13720.588382348546, 14407.207603581799, 23276.185333513415, 2294.265834932822, 2343.168175297762, 2408.2414039577475, 2423.4067563747126, 2567.242663414297, 9768.51157442125, 9935.254855885765, 10268.640597579124, 10433.113185379252, 10553.366797992145, 1695.1354809047475, 1751.4395393474094, 1871.363736329641, 1930.5849242412808, 1937.883726976372, 83918.58040709818, 84849.57575212145, 85833.0, 86578.56710716407, 86981.0, 11409.543618255177, 11661.35862527569, 11828.0, 12015.819762703566, 12299.815502767466, 16909.915450422915, 16935.915320423566, 17000.149992500326, 17026.404075857532, 17028.0, 8518.57407129641, 8581.141885811494, 8632.525211113449, 8661.696840610548, 8767.517786521803, 8242.711505097413, 8252.8349433011, 8292.751217463485, 8386.622601982925, 8453.915460845314, 4943.406791185081, 5054.873628159252, 5063.696178229318, 5113.51421614946, 5214.478552144831, 1859.1355019915804, 1895.9620807583772, 1933.3716542123866, 1939.9030048497518, 1943.7959014303294, 1010.3887148275335, 1056.3081181825917, 1064.4252103863982, 1091.1380009792333, 1110.3227031510771, 19232.23071077141, 19503.902480487508, 20024.69962950557, 20029.29897453582, 20566.69149962752, 1018.2464975917916, 1022.3610243597751, 1035.4977835749655, 1053.4627340056472, 1101.7521057762099, 10999.560017599366, 11209.103271738242, 11227.38249396291, 11297.209195356247, 11339.773204535863, 467686.0, 488527.0, 491400.0, 494480.0, 503493.0, 84253.0, 93293.0, 101143.0, 102213.0, 104368.0, 1079.9956040882055, 1115.2304909612503, 1116.1294190531398, 1122.5565901468874, 1137.6530158301798, 18726.127387261164, 18994.52513687169, 19028.524286892938, 19051.14269857832, 19164.520886977938, 39648.2070358597, 41509.37735933903, 44413.11173776571, 45755.0, 46117.07765844731, 56503.43496565146, 59524.40475595189, 67051.66474167598, 67602.9859552117, 68231.3176868225, 8743.693970710994, 9172.403793753385, 9302.0, 9385.718428447157, 9485.857712134186, 13984.580462586138, 14279.785803212751, 14351.497697580535, 14378.352974116398, 14427.206503642401, 8302.750917472486, 11652.184347095623, 11769.705757356134, 11919.940400297943, 12538.996880249375, 12568.120231584067, 12605.24368537854, 12714.173578717353, 12783.29691866919, 12945.0, 12401.93799030999, 12612.747745045232, 12793.29636869981, 13036.804447933479, 13047.673808154872, 9010.864837027319, 9053.77365565866, 9172.174504294646, 9177.357584968988, 9207.493587852732, 9399.154076133182, 11602.941985290357, 12553.686157846127, 12864.421101050288, 13270.071095023255], "value": 9414.009010298287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.9137749264266, 1621.8459246371594, 1816.5640246340881, 1909.3985394600709, 1935.5257961799362, 8605.741827745162, 9206.309526785484, 9472.147506724394, 10124.139448146907, 10159.695209143729, 9478.099580539838, 9581.37721048133, 9587.952060239706, 9608.951955240214, 9690.709278721632, 2356.045801450411, 2370.845895016827, 2375.3824005758456, 2375.524895020994, 2394.5330660521204, 2371.845830021052, 2400.927972160838, 2417.8791060446906, 2419.177479656916, 2423.745506721795, 2398.5442765874427, 2405.0980882169188, 2426.065964603623, 2426.4904370082218, 2432.9391765205833, 2334.2763743239652, 2342.461233916209, 2357.9882100589475, 2372.92881213563, 2374.8931298091543, 2334.1130370459286, 2354.5526349993447, 2357.446000189954, 2358.50471401006, 2367.443650742074, 9577.760555986086, 9629.0, 9659.420434773936, 9661.613535458644, 9664.516774161335, 5553.888922221573, 5589.357223919261, 5669.433056694339, 5678.148277758328, 5691.0, 3518.313928783888, 3572.214112895159, 3608.5308909841815, 3619.6380361963857, 3646.398344273192, 1144.5593446523064, 1146.1461211397561, 1147.168302980341, 1187.9465424055938, 1192.3680449361852, 14205.431782728678, 14325.0, 14361.928190358982, 14453.205073720941, 14501.05743126704, 4760.714357138513, 4783.278019912828, 4832.855014349575, 4833.492483289204, 4950.0, 11029.338239705643, 11128.387938663289, 11155.665330040112, 11170.329780213213, 11184.44077796107, 5633.155026745939, 5708.800191993343, 5713.114467257582, 5787.971060144672, 5792.044312688444, 4638.141943740419, 5190.455002224712, 5237.5548078413, 5345.438728933484, 5359.383670877821, 4123.711340206157, 4154.293770059097, 4188.078622703, 4203.348480985452, 4211.684123690736, 1171.630936255094, 1173.342927960345, 1206.7767463019195, 1207.1730864357944, 1226.6197478781605, 1030.443560477334, 1104.3705088099707, 1112.6328311657135, 1119.44027986007, 1121.6803211084803, 6649.434798042221, 6713.530052896251, 6851.760188393382, 6878.621675807879, 6879.071325371111, 466.5870704426607, 476.3759475087646, 477.0911413756799, 479.8560431870425, 498.31730529175263, 4565.634749220121, 4614.792334344963, 4615.284630882219, 4650.86047418578, 4670.859874203779, 11959.0, 12462.563810266598, 12473.688157796129, 12933.482660693655, 12936.482540698455, 12739.745205095845, 12764.042696797776, 12783.360831958365, 12814.743705126031, 12842.614721558368, 9231.861522077174, 9419.246460283299, 9470.337076404585, 9482.19401350893, 9493.382930109521, 6475.643839588868, 6732.42774364165, 6787.355201255873, 6791.558548694319, 6912.516123871281, 11378.43107844621, 11526.769464610828, 11607.825882611936, 11832.0, 11856.0, 11842.0, 11907.345096019802, 11933.582324618597, 11963.102767292314, 12067.094967877269, 8412.831743365221, 8640.092790257184, 8672.566371681516, 8799.34004949644, 8947.59735811877, 9747.610095596097, 9783.755406114904, 9802.803943921224, 9811.901880981384, 9826.213902887608, 8425.4944703318, 8660.48037117775, 8681.175288347597, 8751.081136480578, 8786.209241168326, 8544.444611100258, 8562.443441176303, 8603.0, 8628.78428039304, 8796.428232165144, 7744.186860379579, 7835.804104897423, 7897.921020789719, 7906.0, 7929.920700793149, 5715.9142612860005, 5749.597528172988, 5789.4447745690595, 5859.326177489473, 5961.850953726192, 5840.328362238397, 5895.587308888336, 5901.5868889177345, 5936.792212272722, 5988.221531200916], "value": 4984.070083958049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.72555053754843, 344.0658611868777, 348.7593560443293, 349.2160100574211, 351.1344535719452, 5657.603967722261, 5724.427557244274, 5828.562857785667, 5912.88174236515, 5980.282366116066, 5715.199872017921, 5753.683547404891, 5778.162166485857, 5831.737571809268, 5843.590948633598, 4541.205289074399, 4542.364069030338, 4542.454905411347, 4543.363929049936, 4572.154151481986, 4443.266860967952, 4456.777161141946, 4491.191585514606, 4499.122671079141, 4568.703034302776, 4427.114577084596, 4446.310402047217, 4454.53227411122, 4504.806226350003, 4511.796969136397, 4495.685302028843, 4512.932306015412, 4513.2101882170655, 4534.478534968455, 4547.931781023287, 3879.86420475282, 3978.6419222269847, 3981.7013723970526, 4028.637422631977, 4040.878773636796, 5543.77824887004, 5556.361018482886, 5567.749451274703, 5593.937151941118, 5595.272614560122, 5233.110371236899, 5237.633365664405, 5255.605829562798, 5268.367795864521, 5280.973595132, 5927.496162826165, 6066.726997285133, 6069.635821850659, 6072.692376896751, 6153.507719382439, 4413.360062790909, 4415.558444155591, 4439.289713645833, 4445.755483448409, 4462.620677242438, 6223.386177805332, 6281.24625044993, 6304.810855674337, 6330.9683451582905, 6345.9365406345805, 4386.8025938832825, 4483.932741008887, 4488.326750987313, 4490.0, 4521.163584736834, 4540.114677637895, 4579.74811385377, 4590.196715574761, 4591.1965406053805, 4592.2193227151465, 5138.563222126161, 5144.536991670768, 5160.354955630546, 5201.843944681666, 5206.0, 5912.556558258148, 5921.437463440966, 6067.908981365283, 6077.301110372364, 6078.756849725962, 1500.5123334916195, 1516.5905205594647, 1519.9056679190965, 1522.7639715844061, 1534.9539513814605, 908.4594666173616, 947.6114792934864, 952.1145334838667, 983.3706427886159, 1003.7791685829106, 5212.218167274939, 5290.376092376734, 5321.281626980385, 5365.061114304981, 5367.1680889462195, 5591.84713885149, 5596.300462442195, 5598.860028499239, 5614.803481878114, 5650.660960342392, 5072.17401735375, 5243.8164664236565, 5251.76367063483, 5305.65513241638, 5385.353757549119, 2956.763458923324, 2973.8067025643695, 2974.8363839988574, 2997.531209707228, 3054.5265483849594, 5634.352049514277, 5665.291838520185, 5666.46168613981, 5756.827295181151, 5773.364929857712, 5906.763729450774, 6350.523710721714, 6394.520410969103, 6420.844248035399, 6435.581687190318, 6445.4199122079235, 6451.548391612542, 6458.257300410513, 6472.546921715435, 6508.284088750233, 6071.574989750675, 6199.256089269136, 6320.367963203643, 6328.6519241442165, 6330.873382532415, 6175.722092505938, 6207.565470417027, 6251.468625166912, 6256.280527739186, 6297.338779428277, 6266.592671476339, 6297.392361422515, 6409.0, 6469.285639305682, 6471.546991710723, 4322.092360604308, 4395.296752519709, 4400.427944367212, 4410.823567057282, 4417.77911104437, 6062.7271772769445, 6096.451319381277, 6288.27684816252, 6340.112384266298, 6372.490200784019, 6123.908141377794, 6151.630902145886, 6151.876962460815, 6156.0, 6169.383061693795, 6115.84710382244, 6127.172831667668, 6127.417895299939, 6148.047052706837, 6167.475764560063, 5877.0302900021015, 6049.848753781191, 6102.298235702773, 6136.509079273558, 6139.631622102688, 6171.413715697002, 6191.721372538156, 6194.535409844189, 6200.286966998672, 6204.348543403058, 5927.644341339534, 6029.306629737636, 6054.39456054391, 6070.025687413224, 6102.298235702951], "value": 4566.374080508372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.7231982646164, 801.9839603207932, 824.4229039672227, 881.6209030117049, 917.7060344913671, 15763.369465221393, 16068.0, 16961.0, 17163.399281025166, 17200.569985750364, 15243.237838108078, 15282.69434611307, 15380.615484612863, 15405.460808871663, 15437.0, 848.503625379154, 865.9913400865973, 866.2593482572373, 870.4646642314995, 882.8322618702458, 870.8301881133182, 876.3646356391629, 881.3918396306528, 881.5812489067673, 882.7307671160294, 925.9907400926005, 929.6792606550763, 929.7443203119128, 929.9628014879397, 931.4504442378995, 921.760342311004, 923.5659240157182, 925.3846192282158, 925.6575067225136, 927.0636656976469, 672.0490505934098, 675.0751470485467, 679.1815861886415, 679.3681875855452, 680.0275605883585, 16468.752968705478, 16476.258568364454, 16552.66894662112, 16606.169691515377, 16645.750313745302, 13407.262600556965, 13509.932450337783, 13612.863871361258, 14067.155970641794, 15631.531054068397, 13959.0, 13973.371198296101, 14129.293535323295, 14138.50515231962, 14145.080569762933, 4725.57101065023, 4730.692504987199, 4748.335233067373, 4821.300911367832, 4864.124457597631, 73693.63153184253, 76932.61533692351, 77698.61150694267, 78375.21624783793, 78393.21606783917, 11747.177697561088, 11761.941190294165, 11903.940480297542, 11948.462319195656, 12055.21641093326, 20622.484437888874, 20735.377938661863, 20779.480512986993, 20797.58404831895, 20861.269855554983, 8552.230299273095, 8577.01364343096, 8630.395872289006, 8667.263282620921, 9001.0, 4814.1398507127205, 4853.102176097434, 4953.356063711694, 5082.923756143661, 5115.2071428928575, 3675.9816200918826, 3760.2291530236234, 3778.678812300985, 3802.467654528313, 3808.7524310919703, 680.425040840489, 680.43863812355, 686.4474098350776, 688.1260798785514, 697.5326531224092, 668.9732410703517, 669.2103318084706, 671.1912145864222, 707.7443758709995, 714.1109318898006, 8954.86567701485, 9104.772380690403, 9125.406848554823, 9323.813523729623, 9507.429554226768, 616.0236025899001, 619.7335145887222, 715.141829804237, 718.2458418660385, 729.9270072992658, 4564.543545645475, 4587.977060114678, 4598.678092533491, 4604.97697511517, 4686.390769199982, 79576.0, 94205.0, 97203.51398243105, 98886.0, 118763.0, 82076.0, 84439.0, 88279.0, 93943.53028234815, 97644.51177744065, 88499.55750221208, 92065.23804285882, 92266.53866730623, 92647.0, 94710.5264473687, 10523.579056837641, 10574.735631609272, 10678.346989101667, 10691.198160137865, 10826.56693732242, 51212.23181652353, 51470.0, 52758.0, 53742.46257537531, 54460.45539544554, 66879.0, 68414.3158568408, 72156.27843721706, 74810.0, 78767.60616196883, 14176.220307882753, 14319.355628996513, 14388.136711797326, 14620.195889226196, 15037.924810375878, 15337.233138343261, 15705.0, 15721.213939302761, 15944.681106378039, 16271.0, 14706.77939830882, 14774.0, 14872.107673539622, 14971.775423368876, 15314.846851531342, 14356.49752258666, 14424.278786060864, 14611.70776584441, 14696.77954830657, 14739.0, 14481.927590362402, 14501.419943202576, 14622.268886555843, 14685.632859178606, 15004.624884377978, 11949.402529873298, 12026.819597705866, 12027.218230815319, 12165.69585760363, 12778.87221127814, 11986.700332491757, 12021.196820476998, 12448.813267801172, 12686.619401417973, 12974.935125324313], "value": 7920.64600782486, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 113.0, 113.0, 112.0, 111.0, 113.0, 111.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 154.0, 184.0, 127.0, 157.0, 157.0, 126.0, 193.0, 125.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 162.0, 166.0, 163.0, 172.0, 162.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 77.0, 175.0, 75.0, 80.0, 76.0, 76.0, 179.0, 76.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 140.0, 87.0, 85.0, 85.0, 139.0, 85.0, 84.0, 144.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 149.0, 147.0, 147.0, 151.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 54.0, 60.0, 52.0, 53.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 92.0, 76.0, 82.0, 81.0, 78.0, 78.0, 81.0, 101.0, 79.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 125.0, 132.0, 125.0, 120.0, 118.0, 119.0, 119.0, 130.0, 130.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 155.0, 156.0, 159.0, 158.0, 157.0, 154.0, 160.0, 157.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 63.0, 60.0, 61.0, 61.0, 60.0, 61.0], "value": 61.7, "unit": "score"}]}]} 03:45:06 INFO - Return code: 0 03:45:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:06 ERROR - # TBPL SUCCESS # 03:45:06 INFO - Running post-action listener: _resource_record_post_action 03:45:06 INFO - ##### 03:45:06 INFO - ##### Finished run-tests step (success) 03:45:06 INFO - ##### 03:45:06 INFO - Running post-run listener: _resource_record_post_run 03:45:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 503009280; Read time: 276; Write time: 567572 03:45:06 INFO - TinderboxPrint: CPU usage
13.4% 03:45:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 276 03:45:06 INFO - TinderboxPrint: I/O write bytes / time
503,009,280 / 567,572 03:45:06 INFO - TinderboxPrint: CPU idle
8,213.9 (86.6%) 03:45:06 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 03:45:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:45:06 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252817408; Read time: 0; Write time: 375232 03:45:06 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250191872; Read time: 276; Write time: 192340 03:45:06 INFO - Running post-run listener: _upload_blobber_files 03:45:06 INFO - Blob upload gear active. 03:45:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:06 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 03:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:45:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:10 INFO - (blobuploader) - INFO - Done attempting. 03:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:11 INFO - (blobuploader) - INFO - Done attempting. 03:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:12 INFO - (blobuploader) - INFO - Done attempting. 03:45:12 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:12 INFO - Return code: 0 03:45:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22686b228d1c0ae7ca46374352da815be99cb7f72cc549aa7396c25d59204a9b476116f26750e25ceef27373e899eb0fc936801210e175d785d91c0ca582bf4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d6f5b1f51c8dc6610c2cc4980021ef260c99e682f69ef625cf61d8ff4e054ed600d2df92e989e0b7d61d086157c99090fdea2b12de9ac0f36cbddd43d5e6f4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8988383ffc49db0147779931ae0e0a0529d5682f0fcf68846f9a09f19d799c4764cffc8c1a300a9c072e1fdd9e92f4513e93cca2f17ad354514ed3ce6bf6c4"} 03:45:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:12 INFO - Contents: 03:45:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22686b228d1c0ae7ca46374352da815be99cb7f72cc549aa7396c25d59204a9b476116f26750e25ceef27373e899eb0fc936801210e175d785d91c0ca582bf4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d6f5b1f51c8dc6610c2cc4980021ef260c99e682f69ef625cf61d8ff4e054ed600d2df92e989e0b7d61d086157c99090fdea2b12de9ac0f36cbddd43d5e6f4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8988383ffc49db0147779931ae0e0a0529d5682f0fcf68846f9a09f19d799c4764cffc8c1a300a9c072e1fdd9e92f4513e93cca2f17ad354514ed3ce6bf6c4"} 03:45:12 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:12 INFO - Copying logs to upload dir... 03:45:12 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.200785 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-22 03:45:11.626338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:45:11.629711) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22686b228d1c0ae7ca46374352da815be99cb7f72cc549aa7396c25d59204a9b476116f26750e25ceef27373e899eb0fc936801210e175d785d91c0ca582bf4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d6f5b1f51c8dc6610c2cc4980021ef260c99e682f69ef625cf61d8ff4e054ed600d2df92e989e0b7d61d086157c99090fdea2b12de9ac0f36cbddd43d5e6f4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8988383ffc49db0147779931ae0e0a0529d5682f0fcf68846f9a09f19d799c4764cffc8c1a300a9c072e1fdd9e92f4513e93cca2f17ad354514ed3ce6bf6c4"} build_url:https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/fCh36_6kSQeny9iylYEycw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/22686b228d1c0ae7ca46374352da815be99cb7f72cc549aa7396c25d59204a9b476116f26750e25ceef27373e899eb0fc936801210e175d785d91c0ca582bf4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d6f5b1f51c8dc6610c2cc4980021ef260c99e682f69ef625cf61d8ff4e054ed600d2df92e989e0b7d61d086157c99090fdea2b12de9ac0f36cbddd43d5e6f4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8988383ffc49db0147779931ae0e0a0529d5682f0fcf68846f9a09f19d799c4764cffc8c1a300a9c072e1fdd9e92f4513e93cca2f17ad354514ed3ce6bf6c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:45:11.654576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:45:11.654901) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466590629.968525-628929864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:45:11.739981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:45:11.740305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:45:11.740578) ========= ========= Total master_lag: 0.19 =========