builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1465291679.55 results: success (0) buildid: 20160606202128 builduid: 7ec3cba5ae654a229f94a8ace0e91e74 revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.550536) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.551068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.551397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.566256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.566557) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:27:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-06-07 02:27:59 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.665047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.665374) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014513 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:59.714528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:27:59.714900) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e70892847544db94d801f80543fe8a7f6d836f90 --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 e70892847544db94d801f80543fe8a7f6d836f90 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:27:59,892 truncating revision to first 12 chars 2016-06-07 02:27:59,892 Setting DEBUG logging. 2016-06-07 02:27:59,892 attempt 1/10 2016-06-07 02:27:59,892 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e70892847544?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 02:28:00,583 unpacking tar archive at: mozilla-aurora-e70892847544/testing/mozharness/ program finished with exit code 0 elapsedTime=1.080224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:28:00.812173) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:00.812551) ========= script_repo_revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:00.813062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:00.813374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:00.823413) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-07 02:28:00.823740) ========= /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=8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:28:01 INFO - MultiFileLogger online at 20160607 02:28:01 in /builds/slave/test 02:28:01 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 02:28:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:28:01 INFO - {'append_to_log': False, 02:28:01 INFO - 'base_work_dir': '/builds/slave/test', 02:28:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:28:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:28:01 INFO - 'branch': 'Mozilla-Aurora', 02:28:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:28:01 INFO - 'config_files': ('talos/linux_config.py',), 02:28:01 INFO - 'default_actions': ('clobber', 02:28:01 INFO - 'read-buildbot-config', 02:28:01 INFO - 'download-and-extract', 02:28:01 INFO - 'populate-webroot', 02:28:01 INFO - 'create-virtualenv', 02:28:01 INFO - 'install', 02:28:01 INFO - 'run-tests'), 02:28:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:28:01 INFO - 'download_minidump_stackwalk': True, 02:28:01 INFO - 'download_symbols': 'ondemand', 02:28:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:28:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:28:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:28:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:28:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:28:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:28:01 INFO - 'installer_path': 'installer.exe', 02:28:01 INFO - 'log_level': 'info', 02:28:01 INFO - 'log_name': 'talos', 02:28:01 INFO - 'log_to_console': True, 02:28:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:28:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:28:01 INFO - 'opt_config_files': (), 02:28:01 INFO - 'pip_index': False, 02:28:01 INFO - 'sps_profile': False, 02:28:01 INFO - 'sps_profile_interval': 0, 02:28:01 INFO - 'suite': 'dromaeojs-e10s', 02:28:01 INFO - 'system_bits': '32', 02:28:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:28:01 INFO - 'title': 'talos-linux64-ix-001', 02:28:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:28:01 INFO - 'use_talos_json': True, 02:28:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:28:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:28:01 INFO - 'work_dir': 'build'} 02:28:01 INFO - ##### 02:28:01 INFO - ##### Running clobber step. 02:28:01 INFO - ##### 02:28:01 INFO - Running pre-action listener: _resource_record_pre_action 02:28:01 INFO - Running main action method: clobber 02:28:01 INFO - rmtree: /builds/slave/test/build 02:28:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:01 INFO - Running post-action listener: _resource_record_post_action 02:28:01 INFO - ##### 02:28:01 INFO - ##### Finished clobber step (success) 02:28:01 INFO - ##### 02:28:01 INFO - ##### 02:28:01 INFO - ##### Running read-buildbot-config step. 02:28:01 INFO - ##### 02:28:01 INFO - Running pre-action listener: _resource_record_pre_action 02:28:01 INFO - Running main action method: read_buildbot_config 02:28:01 INFO - Using buildbot properties: 02:28:01 INFO - { 02:28:01 INFO - "project": "", 02:28:01 INFO - "product": "firefox", 02:28:01 INFO - "script_repo_revision": "production", 02:28:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:28:01 INFO - "repository": "", 02:28:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:28:01 INFO - "buildid": "20160606202128", 02:28:01 INFO - "pgo_build": "True", 02:28:01 INFO - "basedir": "/builds/slave/test", 02:28:01 INFO - "buildnumber": 392, 02:28:01 INFO - "slavename": "talos-linux64-ix-001", 02:28:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:28:01 INFO - "platform": "ubuntu64_hw", 02:28:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:28:01 INFO - "branch": "mozilla-aurora", 02:28:01 INFO - "repo_path": "releases/mozilla-aurora", 02:28:01 INFO - "revision": "e70892847544db94d801f80543fe8a7f6d836f90", 02:28:01 INFO - "stage_platform": "linux64-pgo", 02:28:01 INFO - "builduid": "7ec3cba5ae654a229f94a8ace0e91e74", 02:28:01 INFO - "slavebuilddir": "test" 02:28:01 INFO - } 02:28:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:28:01 INFO - Running post-action listener: _resource_record_post_action 02:28:01 INFO - ##### 02:28:01 INFO - ##### Finished read-buildbot-config step (success) 02:28:01 INFO - ##### 02:28:01 INFO - ##### 02:28:01 INFO - ##### Running download-and-extract step. 02:28:01 INFO - ##### 02:28:01 INFO - Running pre-action listener: _resource_record_pre_action 02:28:01 INFO - Running main action method: download_and_extract 02:28:01 INFO - mkdir: /builds/slave/test/build/tests 02:28:01 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')]} 02:28:01 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:02 INFO - Downloaded 1361 bytes. 02:28:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:28:02 INFO - Using the following test package requirements: 02:28:02 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:28:02 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:28:02 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:28:02 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'jsshell-linux-x86_64.zip'], 02:28:02 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:28:02 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:28:02 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:28:02 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:28:02 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:28:02 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:28:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:28:02 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:28: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')]} 02:28:02 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:03 INFO - Downloaded 24473779 bytes. 02:28:03 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'] 02:28:03 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 02:28:04 INFO - Return code: 0 02:28:04 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 02:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:04 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:05 INFO - Downloaded 24473779 bytes. 02:28:05 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'] 02:28:05 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 02:28:07 INFO - Return code: 0 02:28:07 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')]} 02:28:07 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:28:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:28:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:28:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:08 INFO - Downloaded 10833369 bytes. 02:28:08 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'] 02:28:08 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 02:28:08 INFO - Return code: 0 02:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:08 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:28:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:28:09 INFO - Downloaded 63553597 bytes. 02:28:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:09 INFO - mkdir: /builds/slave/test/properties 02:28:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:09 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:09 INFO - Contents: 02:28:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:28:10 INFO - Running post-action listener: _resource_record_post_action 02:28:10 INFO - Running post-action listener: set_extra_try_arguments 02:28:10 INFO - ##### 02:28:10 INFO - ##### Finished download-and-extract step (success) 02:28:10 INFO - ##### 02:28:10 INFO - ##### 02:28:10 INFO - ##### Running populate-webroot step. 02:28:10 INFO - ##### 02:28:10 INFO - Running pre-action listener: _resource_record_pre_action 02:28:10 INFO - Running main action method: populate_webroot 02:28:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:10 INFO - '--tppagecycles', 02:28:10 INFO - '7'], 02:28:10 INFO - 'tests': ['tsvgm']}}, 02:28:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['damp', 'tps']}, 02:28:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'tests': ['damp', 'tps']}, 02:28:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['dromaeo_dom']}, 02:28:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['a11yr', 02:28:10 INFO - 'ts_paint', 02:28:10 INFO - 'tpaint', 02:28:10 INFO - 'sessionrestore', 02:28:10 INFO - 'sessionrestore_no_auto_restore', 02:28:10 INFO - 'tabpaint']}, 02:28:10 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:10 INFO - 'ts_paint', 02:28:10 INFO - 'tpaint', 02:28:10 INFO - 'sessionrestore', 02:28:10 INFO - 'sessionrestore_no_auto_restore', 02:28:10 INFO - 'tabpaint']}, 02:28:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:10 INFO - 'ts_paint', 02:28:10 INFO - 'tpaint', 02:28:10 INFO - 'sessionrestore', 02:28:10 INFO - 'sessionrestore_no_auto_restore', 02:28:10 INFO - 'tabpaint']}, 02:28:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:10 INFO - 'ts_paint', 02:28:10 INFO - 'tpaint', 02:28:10 INFO - 'sessionrestore', 02:28:10 INFO - 'sessionrestore_no_auto_restore', 02:28:10 INFO - 'tabpaint']}, 02:28:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['a11yr', 02:28:10 INFO - 'ts_paint', 02:28:10 INFO - 'tpaint', 02:28:10 INFO - 'sessionrestore', 02:28:10 INFO - 'sessionrestore_no_auto_restore', 02:28:10 INFO - 'tabpaint']}, 02:28:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['a11yr', 02:28:10 INFO - 'ts_paint', 02:28:10 INFO - 'tpaint', 02:28:10 INFO - 'sessionrestore', 02:28:10 INFO - 'sessionrestore_no_auto_restore', 02:28:10 INFO - 'tabpaint']}, 02:28:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['tsvgx', 02:28:10 INFO - 'tsvgr_opacity', 02:28:10 INFO - 'tart', 02:28:10 INFO - 'tscrollx', 02:28:10 INFO - 'cart']}, 02:28:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:10 INFO - 'tsvgr_opacity', 02:28:10 INFO - 'tart', 02:28:10 INFO - 'tscrollx', 02:28:10 INFO - 'cart']}, 02:28:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'talos_options': ['--disable-e10s'], 02:28:10 INFO - 'tests': ['tp5o']}, 02:28:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'tests': ['tp5o']}, 02:28:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'talos_options': ['--disable-e10s', 02:28:10 INFO - '--xperf_path', 02:28:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:10 INFO - 'tests': ['tp5n']}, 02:28:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:10 INFO - 'talos_options': ['--xperf_path', 02:28:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:10 INFO - 'tests': ['tp5n']}}, 02:28:10 INFO - 'talos.zip': {'path': '', 02:28:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:10 INFO - Running post-action listener: _resource_record_post_action 02:28:10 INFO - ##### 02:28:10 INFO - ##### Finished populate-webroot step (success) 02:28:10 INFO - ##### 02:28:10 INFO - ##### 02:28:10 INFO - ##### Running create-virtualenv step. 02:28:10 INFO - ##### 02:28:10 INFO - Running pre-action listener: _resource_record_pre_action 02:28:10 INFO - Running main action method: create_virtualenv 02:28:10 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:10 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 02:28:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:10 INFO - Using real prefix '/usr' 02:28:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:13 INFO - Installing pip.................done. 02:28:13 INFO - Return code: 0 02:28:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28: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', 'pip>=1.5'] in /builds/slave/test/build 02:28: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 pip>=1.5 02:28:13 INFO - Using env: {'DISPLAY': ':0', 02:28:13 INFO - 'HOME': '/home/cltbld', 02:28:13 INFO - 'LANG': 'en_US.UTF-8', 02:28:13 INFO - 'LANGUAGE': 'en_US:en', 02:28:13 INFO - 'LOGNAME': 'cltbld', 02:28:13 INFO - 'MAIL': '/var/mail/cltbld', 02:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:13 INFO - 'MOZ_NO_REMOTE': '1', 02:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:13 INFO - 'NO_EM_RESTART': '1', 02:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:13 INFO - 'PWD': '/builds/slave/test', 02:28:13 INFO - 'SHELL': '/bin/bash', 02:28:13 INFO - 'SHLVL': '1', 02:28:13 INFO - 'TERM': 'linux', 02:28:13 INFO - 'TMOUT': '86400', 02:28:13 INFO - 'USER': 'cltbld', 02:28:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:13 INFO - '_': '/tools/buildbot/bin/python'} 02:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:13 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 02:28:13 INFO - Cleaning up... 02:28:13 INFO - Return code: 0 02:28:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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', '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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:28: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 psutil>=3.1.1 02:28:13 INFO - Using env: {'DISPLAY': ':0', 02:28:13 INFO - 'HOME': '/home/cltbld', 02:28:13 INFO - 'LANG': 'en_US.UTF-8', 02:28:13 INFO - 'LANGUAGE': 'en_US:en', 02:28:13 INFO - 'LOGNAME': 'cltbld', 02:28:13 INFO - 'MAIL': '/var/mail/cltbld', 02:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:13 INFO - 'MOZ_NO_REMOTE': '1', 02:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:13 INFO - 'NO_EM_RESTART': '1', 02:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:13 INFO - 'PWD': '/builds/slave/test', 02:28:13 INFO - 'SHELL': '/bin/bash', 02:28:13 INFO - 'SHLVL': '1', 02:28:13 INFO - 'TERM': 'linux', 02:28:13 INFO - 'TMOUT': '86400', 02:28:13 INFO - 'USER': 'cltbld', 02:28:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:13 INFO - '_': '/tools/buildbot/bin/python'} 02:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:13 INFO - Downloading/unpacking psutil>=3.1.1 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:15 INFO - Installing collected packages: psutil 02:28:15 INFO - Running setup.py install for psutil 02:28:15 INFO - building 'psutil._psutil_linux' extension 02:28:15 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 02:28:15 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 02:28:15 INFO - building 'psutil._psutil_posix' extension 02:28:15 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 02:28:15 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 02:28:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:16 INFO - Successfully installed psutil 02:28:16 INFO - Cleaning up... 02:28:16 INFO - Return code: 0 02:28:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:28:16 INFO - Using env: {'DISPLAY': ':0', 02:28:16 INFO - 'HOME': '/home/cltbld', 02:28:16 INFO - 'LANG': 'en_US.UTF-8', 02:28:16 INFO - 'LANGUAGE': 'en_US:en', 02:28:16 INFO - 'LOGNAME': 'cltbld', 02:28:16 INFO - 'MAIL': '/var/mail/cltbld', 02:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:16 INFO - 'MOZ_NO_REMOTE': '1', 02:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:16 INFO - 'NO_EM_RESTART': '1', 02:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:16 INFO - 'PWD': '/builds/slave/test', 02:28:16 INFO - 'SHELL': '/bin/bash', 02:28:16 INFO - 'SHLVL': '1', 02:28:16 INFO - 'TERM': 'linux', 02:28:16 INFO - 'TMOUT': '86400', 02:28:16 INFO - 'USER': 'cltbld', 02:28:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:16 INFO - '_': '/tools/buildbot/bin/python'} 02:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:18 INFO - Installing collected packages: mozsystemmonitor 02:28:18 INFO - Running setup.py install for mozsystemmonitor 02:28:18 INFO - Successfully installed mozsystemmonitor 02:28:18 INFO - Cleaning up... 02:28:18 INFO - Return code: 0 02:28:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:18 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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:18 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 02:28:18 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 02:28:18 INFO - Using env: {'DISPLAY': ':0', 02:28:18 INFO - 'HOME': '/home/cltbld', 02:28:18 INFO - 'LANG': 'en_US.UTF-8', 02:28:18 INFO - 'LANGUAGE': 'en_US:en', 02:28:18 INFO - 'LOGNAME': 'cltbld', 02:28:18 INFO - 'MAIL': '/var/mail/cltbld', 02:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:18 INFO - 'MOZ_NO_REMOTE': '1', 02:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:18 INFO - 'NO_EM_RESTART': '1', 02:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:18 INFO - 'PWD': '/builds/slave/test', 02:28:18 INFO - 'SHELL': '/bin/bash', 02:28:18 INFO - 'SHLVL': '1', 02:28:18 INFO - 'TERM': 'linux', 02:28:18 INFO - 'TMOUT': '86400', 02:28:18 INFO - 'USER': 'cltbld', 02:28:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:18 INFO - '_': '/tools/buildbot/bin/python'} 02:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:18 INFO - Downloading/unpacking jsonschema==2.5.1 02:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:20 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 02:28:20 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 02:28:20 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 02:28:20 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 02:28:20 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 02:28:20 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 02:28:20 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:20 INFO - warning: no files found matching '*.txt' 02:28:20 INFO - no previously-included directories found matching 'build' 02:28:20 INFO - no previously-included directories found matching 'dist' 02:28:20 INFO - no previously-included directories found matching '.git*' 02:28:20 INFO - Installing collected packages: jsonschema, functools32 02:28:20 INFO - Running setup.py install for functools32 02:28:20 INFO - warning: no files found matching '*.txt' 02:28:20 INFO - no previously-included directories found matching 'build' 02:28:20 INFO - no previously-included directories found matching 'dist' 02:28:20 INFO - no previously-included directories found matching '.git*' 02:28:20 INFO - Successfully installed jsonschema functools32 02:28:20 INFO - Cleaning up... 02:28:20 INFO - Return code: 0 02:28:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28:20 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')]} 02:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:21 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')]} 02:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:21 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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:21 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 02:28:21 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 02:28:21 INFO - Using env: {'DISPLAY': ':0', 02:28:21 INFO - 'HOME': '/home/cltbld', 02:28:21 INFO - 'LANG': 'en_US.UTF-8', 02:28:21 INFO - 'LANGUAGE': 'en_US:en', 02:28:21 INFO - 'LOGNAME': 'cltbld', 02:28:21 INFO - 'MAIL': '/var/mail/cltbld', 02:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:21 INFO - 'MOZ_NO_REMOTE': '1', 02:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:21 INFO - 'NO_EM_RESTART': '1', 02:28:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:21 INFO - 'PWD': '/builds/slave/test', 02:28:21 INFO - 'SHELL': '/bin/bash', 02:28:21 INFO - 'SHLVL': '1', 02:28:21 INFO - 'TERM': 'linux', 02:28:21 INFO - 'TMOUT': '86400', 02:28:21 INFO - 'USER': 'cltbld', 02:28:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:21 INFO - '_': '/tools/buildbot/bin/python'} 02:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:21 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:21 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 02:28:21 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 02:28:21 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 02:28:21 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 02:28:21 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 02:28:21 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 02:28:23 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 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 02:28:23 INFO - Downloading docopt-0.6.1.tar.gz 02:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:23 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:23 INFO - Running setup.py install for blobuploader 02:28:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:23 INFO - Running setup.py install for requests 02:28:24 INFO - Running setup.py install for docopt 02:28:24 INFO - Successfully installed blobuploader requests docopt 02:28:24 INFO - Cleaning up... 02:28:24 INFO - Return code: 0 02:28:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:24 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')]} 02:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:24 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')]} 02:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:24 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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:24 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 02:28:24 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 02:28:24 INFO - Using env: {'DISPLAY': ':0', 02:28:24 INFO - 'HOME': '/home/cltbld', 02:28:24 INFO - 'LANG': 'en_US.UTF-8', 02:28:24 INFO - 'LANGUAGE': 'en_US:en', 02:28:24 INFO - 'LOGNAME': 'cltbld', 02:28:24 INFO - 'MAIL': '/var/mail/cltbld', 02:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:24 INFO - 'MOZ_NO_REMOTE': '1', 02:28:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:24 INFO - 'NO_EM_RESTART': '1', 02:28:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:24 INFO - 'PWD': '/builds/slave/test', 02:28:24 INFO - 'SHELL': '/bin/bash', 02:28:24 INFO - 'SHLVL': '1', 02:28:24 INFO - 'TERM': 'linux', 02:28:24 INFO - 'TMOUT': '86400', 02:28:24 INFO - 'USER': 'cltbld', 02:28:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:24 INFO - '_': '/tools/buildbot/bin/python'} 02:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:24 INFO - Running setup.py (path:/tmp/pip-_zfH1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:24 INFO - Running setup.py (path:/tmp/pip-N1WbCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:24 INFO - Running setup.py (path:/tmp/pip-nMEF7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:24 INFO - Running setup.py (path:/tmp/pip-6VCvEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:24 INFO - Running setup.py (path:/tmp/pip-1SwY1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:25 INFO - Running setup.py (path:/tmp/pip-TXVdhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:25 INFO - Running setup.py (path:/tmp/pip-sAB0k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:25 INFO - Running setup.py (path:/tmp/pip-A1wyid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:25 INFO - Running setup.py (path:/tmp/pip-kbURPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:25 INFO - Running setup.py (path:/tmp/pip-tFyH6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:25 INFO - Running setup.py (path:/tmp/pip-iuIE4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:25 INFO - Running setup.py (path:/tmp/pip-zl6eXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:25 INFO - Running setup.py (path:/tmp/pip-nQflBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:25 INFO - Running setup.py (path:/tmp/pip-ZCid26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:25 INFO - Running setup.py (path:/tmp/pip-v7sUdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:25 INFO - Running setup.py (path:/tmp/pip-nrAdGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:25 INFO - Running setup.py (path:/tmp/pip-gfVuYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:25 INFO - Running setup.py install for manifestparser 02:28:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:25 INFO - Running setup.py install for mozcrash 02:28:26 INFO - Running setup.py install for mozdebug 02:28:26 INFO - Running setup.py install for mozdevice 02:28:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for mozfile 02:28:26 INFO - Running setup.py install for mozhttpd 02:28:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for mozinfo 02:28:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for mozInstall 02:28:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for mozleak 02:28:26 INFO - Running setup.py install for mozlog 02:28:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:26 INFO - Running setup.py install for moznetwork 02:28:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:27 INFO - Running setup.py install for mozprocess 02:28:27 INFO - Running setup.py install for mozprofile 02:28:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:27 INFO - Running setup.py install for mozrunner 02:28:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:27 INFO - Running setup.py install for mozscreenshot 02:28:27 INFO - Running setup.py install for moztest 02:28:27 INFO - Running setup.py install for mozversion 02:28:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:27 INFO - Cleaning up... 02:28:27 INFO - Return code: 0 02:28:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:27 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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:27 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 02:28:27 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 02:28:27 INFO - Using env: {'DISPLAY': ':0', 02:28:27 INFO - 'HOME': '/home/cltbld', 02:28:27 INFO - 'LANG': 'en_US.UTF-8', 02:28:27 INFO - 'LANGUAGE': 'en_US:en', 02:28:27 INFO - 'LOGNAME': 'cltbld', 02:28:27 INFO - 'MAIL': '/var/mail/cltbld', 02:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:27 INFO - 'MOZ_NO_REMOTE': '1', 02:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:27 INFO - 'NO_EM_RESTART': '1', 02:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:27 INFO - 'PWD': '/builds/slave/test', 02:28:27 INFO - 'SHELL': '/bin/bash', 02:28:27 INFO - 'SHLVL': '1', 02:28:27 INFO - 'TERM': 'linux', 02:28:27 INFO - 'TMOUT': '86400', 02:28:27 INFO - 'USER': 'cltbld', 02:28:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:27 INFO - '_': '/tools/buildbot/bin/python'} 02:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:27 INFO - Running setup.py (path:/tmp/pip-R5Xyaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:27 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)) 02:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:27 INFO - Running setup.py (path:/tmp/pip-2lJ2AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:28 INFO - Running setup.py (path:/tmp/pip-BRzOzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:28 INFO - Running setup.py (path:/tmp/pip-IDNI_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:28 INFO - Running setup.py (path:/tmp/pip-P7akFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:28 INFO - Running setup.py (path:/tmp/pip-gXmNhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:28 INFO - Running setup.py (path:/tmp/pip-8am3hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:28 INFO - Running setup.py (path:/tmp/pip-s18jBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:28 INFO - Running setup.py (path:/tmp/pip-p8j0eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:28 INFO - Running setup.py (path:/tmp/pip-iORBo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:28 INFO - Running setup.py (path:/tmp/pip-Sd9E9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:28 INFO - Running setup.py (path:/tmp/pip-R8TG1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:28 INFO - Running setup.py (path:/tmp/pip-K2S220-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:28 INFO - Running setup.py (path:/tmp/pip-wjSpk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:28 INFO - Running setup.py (path:/tmp/pip-m01KBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:28 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)) 02:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:29 INFO - Running setup.py (path:/tmp/pip-qsLCJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:29 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)) 02:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:29 INFO - Running setup.py (path:/tmp/pip-zMEJMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:29 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)) 02:28:29 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)) 02:28:29 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)) 02:28:29 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)) 02:28:29 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)) 02:28:29 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)) 02:28:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:29 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 02:28:29 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 02:28:29 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 02:28:29 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 02:28:29 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 02:28:29 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 02:28:31 INFO - Downloading blessings-1.6.tar.gz 02:28:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:31 INFO - Installing collected packages: blessings 02:28:31 INFO - Running setup.py install for blessings 02:28:31 INFO - Successfully installed blessings 02:28:31 INFO - Cleaning up... 02:28:31 INFO - Return code: 0 02:28:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:31 INFO - Reading from file tmpfile_stdout 02:28:31 INFO - Current package versions: 02:28:31 INFO - argparse == 1.2.1 02:28:31 INFO - blessings == 1.6 02:28:31 INFO - blobuploader == 1.2.4 02:28:31 INFO - docopt == 0.6.1 02:28:31 INFO - functools32 == 3.2.3-2 02:28:31 INFO - jsonschema == 2.5.1 02:28:31 INFO - manifestparser == 1.1 02:28:31 INFO - mozInstall == 1.12 02:28:31 INFO - mozcrash == 0.17 02:28:31 INFO - mozdebug == 0.1 02:28:31 INFO - mozdevice == 0.48 02:28:31 INFO - mozfile == 1.2 02:28:31 INFO - mozhttpd == 0.7 02:28:31 INFO - mozinfo == 0.9 02:28:31 INFO - mozleak == 0.1 02:28:31 INFO - mozlog == 3.2 02:28:31 INFO - moznetwork == 0.27 02:28:31 INFO - mozprocess == 0.22 02:28:31 INFO - mozprofile == 0.28 02:28:31 INFO - mozrunner == 6.11 02:28:31 INFO - mozscreenshot == 0.1 02:28:31 INFO - mozsystemmonitor == 0.3 02:28:31 INFO - moztest == 0.7 02:28:31 INFO - mozversion == 1.4 02:28:31 INFO - psutil == 3.1.1 02:28:31 INFO - requests == 1.2.3 02:28:31 INFO - wsgiref == 0.1.2 02:28:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:31 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')]} 02:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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')]} 02:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:31 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 02:28:31 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 02:28:31 INFO - Using env: {'DISPLAY': ':0', 02:28:31 INFO - 'HOME': '/home/cltbld', 02:28:31 INFO - 'LANG': 'en_US.UTF-8', 02:28:31 INFO - 'LANGUAGE': 'en_US:en', 02:28:31 INFO - 'LOGNAME': 'cltbld', 02:28:31 INFO - 'MAIL': '/var/mail/cltbld', 02:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:31 INFO - 'MOZ_NO_REMOTE': '1', 02:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:31 INFO - 'NO_EM_RESTART': '1', 02:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:31 INFO - 'PWD': '/builds/slave/test', 02:28:31 INFO - 'SHELL': '/bin/bash', 02:28:31 INFO - 'SHLVL': '1', 02:28:31 INFO - 'TERM': 'linux', 02:28:31 INFO - 'TMOUT': '86400', 02:28:31 INFO - 'USER': 'cltbld', 02:28:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:31 INFO - '_': '/tools/buildbot/bin/python'} 02:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 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)) 02:28:31 INFO - Cleaning up... 02:28:31 INFO - Return code: 0 02:28:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:31 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')]} 02:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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')]} 02:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:31 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 02:28:31 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 02:28:31 INFO - Using env: {'DISPLAY': ':0', 02:28:31 INFO - 'HOME': '/home/cltbld', 02:28:31 INFO - 'LANG': 'en_US.UTF-8', 02:28:31 INFO - 'LANGUAGE': 'en_US:en', 02:28:31 INFO - 'LOGNAME': 'cltbld', 02:28:31 INFO - 'MAIL': '/var/mail/cltbld', 02:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:31 INFO - 'MOZ_NO_REMOTE': '1', 02:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:31 INFO - 'NO_EM_RESTART': '1', 02:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:31 INFO - 'PWD': '/builds/slave/test', 02:28:31 INFO - 'SHELL': '/bin/bash', 02:28:31 INFO - 'SHLVL': '1', 02:28:31 INFO - 'TERM': 'linux', 02:28:31 INFO - 'TMOUT': '86400', 02:28:31 INFO - 'USER': 'cltbld', 02:28:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:31 INFO - '_': '/tools/buildbot/bin/python'} 02:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:31 INFO - Cleaning up... 02:28:31 INFO - Return code: 0 02:28:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:28:31 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')]} 02:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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')]} 02:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:31 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 0x7f1c614fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', '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 02:28:31 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 02:28:31 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 02:28:31 INFO - Using env: {'DISPLAY': ':0', 02:28:31 INFO - 'HOME': '/home/cltbld', 02:28:31 INFO - 'LANG': 'en_US.UTF-8', 02:28:31 INFO - 'LANGUAGE': 'en_US:en', 02:28:31 INFO - 'LOGNAME': 'cltbld', 02:28:31 INFO - 'MAIL': '/var/mail/cltbld', 02:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:31 INFO - 'MOZ_NO_REMOTE': '1', 02:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:31 INFO - 'NO_EM_RESTART': '1', 02:28:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:31 INFO - 'PWD': '/builds/slave/test', 02:28:31 INFO - 'SHELL': '/bin/bash', 02:28:31 INFO - 'SHLVL': '1', 02:28:31 INFO - 'TERM': 'linux', 02:28:31 INFO - 'TMOUT': '86400', 02:28:31 INFO - 'USER': 'cltbld', 02:28:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:31 INFO - '_': '/tools/buildbot/bin/python'} 02:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:32 INFO - Downloading/unpacking flake8 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:32 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 02:28:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:28:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:28:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 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 02:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:28:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:28:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:28:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:28:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:28:34 INFO - no previously-included directories found matching 'docs/_build' 02:28:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:28:34 INFO - Running setup.py install for pep8 02:28:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:28:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:28:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:28:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:28:34 INFO - no previously-included directories found matching 'docs/_build' 02:28:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:28:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:28:34 INFO - Cleaning up... 02:28:35 INFO - Return code: 0 02:28:35 INFO - Running post-action listener: _resource_record_post_action 02:28:35 INFO - Running post-action listener: _start_resource_monitoring 02:28:35 INFO - Starting resource monitoring. 02:28:35 INFO - ##### 02:28:35 INFO - ##### Finished create-virtualenv step (success) 02:28:35 INFO - ##### 02:28:35 INFO - ##### 02:28:35 INFO - ##### Running install step. 02:28:35 INFO - ##### 02:28:35 INFO - Running pre-action listener: _resource_record_pre_action 02:28:35 INFO - Running main action method: install 02:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:35 INFO - Reading from file tmpfile_stdout 02:28:35 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:35 INFO - Reading from file tmpfile_stdout 02:28:35 INFO - Output received: 02:28:35 INFO - Usage: mozinstall [options] installer 02:28:35 INFO - Options: 02:28:35 INFO - -h, --help show this help message and exit 02:28:35 INFO - -d DEST, --destination=DEST 02:28:35 INFO - Directory to install application into. [default: 02:28:35 INFO - "/builds/slave/test"] 02:28:35 INFO - --app=APP Application being installed. [default: firefox] 02:28:35 INFO - mkdir: /builds/slave/test/build/application 02:28:35 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'] 02:28:35 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 02:28:51 INFO - Reading from file tmpfile_stdout 02:28:51 INFO - Output received: 02:28:51 INFO - /builds/slave/test/build/application/firefox/firefox 02:28:51 INFO - Running post-action listener: _resource_record_post_action 02:28:51 INFO - ##### 02:28:51 INFO - ##### Finished install step (success) 02:28:51 INFO - ##### 02:28:51 INFO - ##### 02:28:51 INFO - ##### Running run-tests step. 02:28:51 INFO - ##### 02:28:51 INFO - Running pre-action listener: _resource_record_pre_action 02:28:51 INFO - Running main action method: run_tests 02:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:51 INFO - Python 2.7.3 02:28:51 INFO - Return code: 0 02:28:51 INFO - grabbing minidump binary from tooltool 02:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:51 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 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:51 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 02:28:51 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 02:28:51 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 02:28:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:51 INFO - Return code: 0 02:28:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:28:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:28:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:28:52 INFO - Return code: 0 02:28:52 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/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:28:52 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/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:28:52 INFO - Using env: {'DISPLAY': ':0', 02:28:52 INFO - 'HOME': '/home/cltbld', 02:28:52 INFO - 'LANG': 'en_US.UTF-8', 02:28:52 INFO - 'LANGUAGE': 'en_US:en', 02:28:52 INFO - 'LOGNAME': 'cltbld', 02:28:52 INFO - 'MAIL': '/var/mail/cltbld', 02:28:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:52 INFO - 'MOZ_NO_REMOTE': '1', 02:28:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:52 INFO - 'NO_EM_RESTART': '1', 02:28:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:52 INFO - 'PWD': '/builds/slave/test', 02:28:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:52 INFO - 'SHELL': '/bin/bash', 02:28:52 INFO - 'SHLVL': '1', 02:28:52 INFO - 'TERM': 'linux', 02:28:52 INFO - 'TMOUT': '86400', 02:28:52 INFO - 'USER': 'cltbld', 02:28:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685', 02:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:52 INFO - '_': '/tools/buildbot/bin/python'} 02:28:52 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/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:28:52 INFO - mozversion application_buildid: 20160606202128 02:28:52 INFO - mozversion application_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:28:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:28:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:52 INFO - mozversion application_name: Firefox 02:28:52 INFO - mozversion application_remotingname: firefox-dev 02:28:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:52 INFO - mozversion application_vendor: Mozilla 02:28:52 INFO - mozversion application_version: 49.0a2 02:28:52 INFO - mozversion platform_buildid: 20160606202128 02:28:52 INFO - mozversion platform_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:28:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:52 INFO - mozversion platform_version: 49.0a2 02:28:52 INFO - using testdate: 1465291732 02:28:52 INFO - actual date: 1465291732 02:28:52 INFO - starting webserver on 'localhost:41147' 02:28:52 INFO - SUITE-START | Running 2 tests 02:28:52 INFO - TEST-START | dromaeo_css 02:28:52 INFO - operating with platform_type : linux_ 02:28:52 INFO - Initialising browser for dromaeo_css test... 02:28:52 INFO - TEST-INFO | started process 9398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnjNviX/profile http://localhost:41147/getInfo.html) 02:28:57 INFO - PROCESS | 9398 | __metrics Screen width/height:1600/1200 02:28:57 INFO - PROCESS | 9398 | colorDepth:24 02:28:57 INFO - PROCESS | 9398 | Browser inner width/height: 1024/697 02:28:57 INFO - PROCESS | 9398 | __metrics 02:28:57 ERROR - PROCESS | 9398 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 02:28:58 INFO - TEST-INFO | 9398: exit 0 02:28:58 INFO - Browser initialized. 02:28:58 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:58 INFO - TEST-INFO | started process 9526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnjNviX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:10 INFO - PROCESS | 9526 | RSS: Main: 156205056 02:29:10 INFO - PROCESS | 9526 | 02:30:00 INFO - PROCESS | 9526 | 1465291800129 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] 02:32:08 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:41147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41147/tests/dromaeo/cssquery-ext.html) 02:32:09 INFO - PROCESS | 9526 | RSS: Main: 159981568 02:32:09 INFO - PROCESS | 9526 | 02:35:11 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:41147/tests/dromaeo/cssquery-ext.html (next: http://localhost:41147/tests/dromaeo/cssquery-jquery.html) 02:35:11 INFO - PROCESS | 9526 | RSS: Main: 157859840 02:35:11 INFO - PROCESS | 9526 | 02:38:13 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:41147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41147/tests/dromaeo/cssquery-mootools.html) 02:38:14 INFO - PROCESS | 9526 | RSS: Main: 157040640 02:38:14 INFO - PROCESS | 9526 | 02:41:15 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:41147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41147/tests/dromaeo/cssquery-prototype.html) 02:41:16 INFO - PROCESS | 9526 | RSS: Main: 156934144 02:41:16 INFO - PROCESS | 9526 | 02:44:18 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:41147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41147/tests/dromaeo/cssquery-yui.html) 02:44:19 INFO - PROCESS | 9526 | RSS: Main: 159563776 02:44:19 INFO - PROCESS | 9526 | 02:47:21 INFO - PROCESS | 9526 | Cycle 1(1): loaded http://localhost:41147/tests/dromaeo/cssquery-yui.html (next: http://localhost:41147/tests/dromaeo/cssquery-dojo.html) 02:47:22 INFO - PROCESS | 9526 | RSS: Main: 159424512 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | __start_tp_report 02:47:22 INFO - PROCESS | 9526 | _x_x_mozilla_page_load 02:47:22 INFO - PROCESS | 9526 | _x_x_mozilla_page_load_details 02:47:22 INFO - PROCESS | 9526 | |i|pagename|runs| 02:47:22 INFO - PROCESS | 9526 | |0;dojo.html;3263.4615288477403;3309.437395642741;3411.607665118512;3433.914152146196;3438.381091403548;5748.281464816898;5792.391798861122;5804.187413762077;5826.679532625704;5850.5612079094135;5812.709364531767;5862.472377486026;5881.764729410818;5887.499562537189;5902.527797776178;5200.32395788547;5275;5309.867253318678;5327.493888080626;5369.275147855029;5187.4034486034025;5189.7405129743365;5353.7590808413715;5364.356277246736;5389.407165211824;5223.242629818674;5301.1783173608155;5304.734763261841;5333.226682131089;5336.066188417031;5368.8389348319615;5382.838514844561;5386.946130538684;5419.972900135494;5422.6475279106735;5102.668326558762;5184.5593124584075;5225.425203227642;5301.893962120775;5351.598630102758;5675.460831221028;5732.541396688297;5734.340550836666;5773.39379365169;5800.274965629296;6269.62382257066;6292.5595208335435;6292.905606415908;6295.118683384284;6315.778947736807;6082.847928801771;6100.877982440371;6114.844865410725;6339.651319177444;6362.0456931460185;5814.418558144152;5814.680192589448;5824.068149096124;5836.88326233473;5843.649381037151;6333.36666333363;6341.904871426932;6362.300146983828;6365.586236894587;6375.489960803125;5886.646801191942;6009.939900601025;6018.548608854353;6069.605475644069;6073.848153796102;6216.5605095541405;6218.378162183836;6219.906701399483;6232.501399887998;6251.718672659741;6134.478569321568;6172.290186628506;6189.907151392733;6199.690015499207;6223.222097237845;5957.821265362046;6067.332593414721;6100.8779824404155;6118.418750218722;6165.724445154671;4709.905801883943;4710.293455981561;4713.457952335457;4725.102230576248;4754.02542478791;4127.463429754112;4211.663066954637;4225.070484493406;4225.492940847118;4240.957590424118;5759.625624334489;5877.265341832271;5889.204957330791;5891.970540147272;5928.110783382527;6169.321374648785;6180.443760061616;6227.750889964351;6269.592476489013;6276.1213430118905;5799.594028418054;5985.670788106696;5988.041913293852;6024.324216728404;6034.758609655652;5308.92036619451;5334.306540149756;5343.171808369709;5347.465253474621;5375.838724838261;6458.2895881453005;6469.805905822833;6475;6500.9349906501275;6513.73945042193;6034.306054803754;6132.447291485866;6246.46905013079;6257.5932564383165;6260.655663938527;6414.647194404352;6528.510361722985;6530.47756179495;6538.705758240795;6543.869122617426;6092.45167934888;6166.2600487939935;6170.043643235305;6170.753169873155;6194.783182588588;6030.517558595214;6193.535484838565;6253.530985176221;6296.937030629635;6298.874022519615;6114.357992410733;6162.198914141133;6174.043023331391;6177.81466556004;6180.783672571439;6142.41647043548;6152.846178845564;6153.2000839890525;6167.167432396748;6176.073588961692;5777.6822274775295;5859.765609375577;5881.735321910439;5912.556558258062;6037.818865434044;6048.5161187105805;6085.330613632408;6094.573379863367;6102.938970610237;6132.049532322497;6007.8197654070445;6012.6993650316435;6012.759489620366;6021.367756385516;6021.548383871314 02:47:22 INFO - PROCESS | 9526 | |1;ext.html;577.2611057845957;638.5944924972642;648.6400047973373;659.3538332434217;661.5633681770031;47817;48951.75524122384;49451.75274123625;49623;52528.47471525293;48225.27662085072;48618.75690621551;48901.266481002815;48928.75535622317;48936;9024.593893274818;9196.218321442686;9200.263978881707;9216.262698984065;9217.400868943498;9153.313501487382;9184.448933064037;9187.908120918806;9192.172704456598;9214.262858971266;9319.114684105;9322.720318390458;9364.765880852965;9369.390989585689;9372.156505914467;9193.08069193082;9225.492597907112;9232.6306947722;9243.352965292432;9297.302702297355;9115.316351273616;9174.174324310845;9189.724308270763;9249.491277979709;9255.352125351228;45523.54476455226;45596;45917.54082459166;46046.07907841858;46154.76922615366;3593.2274560969254;3751.8311675974646;4261.87214383569;4441.578050085237;4453.821847126143;32757;32993;33040;33310.167245818804;34602.13494662628;4731.621470282369;4757.857264282043;4775.498572649856;4780.569748722632;4798.49615790344;375164.1241793801;375490;376947;377059;378447;66985;67007;67217;67305.66347168233;67448;40694.38958415626;41064.17871642551;41513;43141.784291078344;43186.13627727428;17625.823741762673;17839.554011149827;17868.910655446638;17883;17890.194941227677;14248.572542823731;14285.57143285703;14287;14387.856121438652;14425.567232983027;22134.88932555359;22153.77846221517;22240.777592224193;22250.666240006412;22288.88855555744;7626.313631773167;7653.3494652954005;7675.462717609826;7737.922620773833;7905.328047115944;1019.3883669798062;1063.0963680871353;1143.6854864912216;1146.8795776443353;1229.0843321725372;33885;33981.490277645855;34011.82994085014;34356.48465273023;34884.30231395409;1170.2042611024585;1192.2786714038054;1232.3160645841645;1241.4661695470854;1250.8936740376987;17913.7312940306;17976.640467190846;18038.819611803978;18198.818011819978;18330.083495825424;544908;620761;644379;654785;656555;64390.678046609464;64879.351206488274;65347;65585.67207164029;65638;1442.985570144285;1449.2319370368134;1451.8765904898203;1453.4840131753076;1461.8611231933162;32612.34775304433;32963;33129.83435082809;33551.83224083961;34013.48979765256;54715.72642136764;55211.17183242174;55368;55438;55561;422122;426204;426920;427895;428424;30991.690083099784;31122;31359.686403135678;31369.21576960503;31386.372272553963;50040.49959500358;50409.49590504048;50639.240411394596;51029;51649.741751291;42096.57903421049;43642.56357436512;43659.78170109129;43861.34207986819;44306.77846610746;43461;43519.564804351554;43726.12547749091;43916.12167756691;44179.116417670826;42695.146097078505;42860.571394286904;42918;45305.54694453145;46204.306935395325;39665;40379;40769;41551.37672934848;41979.37030944599;30347.848260758554;30485.23786905345;31162.22094447657;31205.063848084596;31408 02:47:22 INFO - PROCESS | 9526 | |2;jquery.html;419.7796157017567;425.88288220739304;429.9462567179103;434.68485348122596;442.2040327410662;18750.343737969157;19843.801561984375;20451.386458406254;20839.791602084013;20848.791512084874;19148.234070637194;19856.900715496402;20169.890656013915;20942.685859712077;21053.894730526325;5786.68173250471;5962.195103661015;5983.042713165894;5993.550483713717;6000.639961602296;5738.913916291259;5741.454561816641;5751.453611906883;5886.911696324559;5934.376890426508;5695.487406133468;5743.4543718346695;5760.798372056979;5771.653700777946;5790.884182316351;5637.746301416426;5764.884702305952;5765.192872997763;5974.820755377345;5985.4912332451795;5737.655740655532;5820.708964551798;5842.678652674102;5884.823455296348;5937.910931336033;14703.705925881422;14943.925280373638;15111.093334399971;15250.313735881911;15253.08481491103;2391.6053851114543;2468.2101727447225;2468.827182097254;2481.2184161988916;2532.632768248612;11319;11323.150763692756;11366.602168924048;11423.828642570368;14701;2077.480629842539;2090.8918273315167;2132.7227460430045;2139.422355963881;2185.0276626900877;54665.726671366785;76497.23502764957;91553.54223228908;92793.5360323194;93838.53080734552;10740.570377184982;10880.572619624792;10969.616063437901;11166.218364714554;11277.605283815026;15157.166355850313;15297.082175069532;15358.692826143639;15514.767278490832;15595.922020389826;7917.970663813782;7923.9603801981775;8433.072362040171;8562.100979397073;8666.653333866701;8497.70258040978;8602.87095693565;8736.694215702548;8740.562971851383;8836.160564746468;4726.314684370747;4840.080384726891;4896.559309662148;4956.231784073474;5021.271915572222;2103.3059090500096;2120.8091271785615;2137.7648458669532;2151.978480215209;2176.6952626632283;1027.527337424793;1052.6789329254498;1085.9294145880492;1095.775366049958;1193.797054500737;18532.351367702067;19343.709844352346;19376.321828735927;20388.96110388949;20433;1047.9633212837514;1053.4364115198332;1057.984130238047;1076.7738774857212;1107.341132026443;10847.67456976292;11289.322640641587;11300.660980170607;11327.943360283145;11405.828912566318;472178;474971;478641;483937;488814;100790;103788.48105759574;103992;107012;107557.46221268844;1068.8076146293586;1096.4627332606965;1105.6682995101598;1105.9170562207867;1116.0903863351343;17710.203040862936;17909.19408626641;17996.460106196835;18164;18170.45488635343;30109;44725.55274447344;44893.551064490246;45019.77490112528;46826;63561.6821915906;64092;64641;65116.34883651103;65469.34530654823;8752.649894004424;8828.867566986628;8982.371234013817;8998.370114091951;9471;10634.52144653508;12904.8064279034;13227.867721322664;13288.468461261828;14167.787483187554;11896.167268291483;11992.160548761853;12037.217580857216;12144.939275303566;12195.75608487843;11677.299362038304;11687;11995.64013079609;12291.262524248574;12428.813567796671;12103.515859365527;12186.817197741864;12194.207376520499;12195.75608487843;12333.62999110028;8684.2184203422;8748.212660860552;8987.640494380152;9025.819483610423;9037.77405564866;11619.941900290445;11865;11962.043036557228;12000.279983201035;12269.325187114437 02:47:22 INFO - PROCESS | 9526 | |3;mootools.html;1637.5169325049112;1648.8103868055173;1879.9812001879977;1943.0964601460337;1955.1690531524098;8530.616122274498;8937.704032915231;9519.666811661593;9545.57044932978;9602.087801658849;9613.951930240357;9892.258080643944;10005.499725013757;10017.398956062623;10018.398896066241;2495.226479791266;2508.3352911478473;2526.9241922742253;2534.809889258304;2539.6317533957567;2478.9752102478924;2542.4025354041787;2551.8213725039254;2555.565553855849;2555.6933168019773;2500.087468074158;2500.299916023507;2546.401595625027;2551.6045013023013;2557.4501482181327;2381.7022872140983;2382.201962342617;2400.543896659629;2410.963835542468;2432.574299497581;2359.2332491940015;2400;2410.6384042393606;2412.1316326122583;2418.3470462975074;9824.361416507976;9853.310268281222;9902;9908.455034973074;9917.206623470105;5828.533717302648;5913.822585322448;5930.911036334458;5939.465448109648;5979.641221526722;3701.5188025556504;3779.622037796226;3876.7286289959716;3889.2221555688693;3907.9218415631813;1177.0818761366063;1204;1215.6353094071744;1237.7586370657725;1267.1256832785348;14330.49843255481;14344.56966291013;14411.78382324266;14464.421423143061;14494.275286235646;5090.541851233407;5122.874007286934;5320.627556071038;5332.520073193431;5415.891682166334;11111.277766945122;11188.272762270426;11206.383648899226;11219.60731374398;11248.775024499464;5861.20873682056;5865.794697185578;5866.442687944638;5885.352611212763;5891.911621325684;4857.247126695368;5394.163904594794;5433.157860531624;5485.972570137204;5492.81904390558;3953.2686453006286;3957.2679054375035;3959.7624142550962;4016.163697049538;4071.7353372030725;1180.5159884447507;1220.1519943639087;1230.889219970189;1242.310517662706;1243.9813402798966;890.7060669978891;905.4612505559181;934.621478301289;966.9750064931195;1019.2202964731986;6373.490120790326;6677.09859169006;6679.165104361955;6763.12079429671;6764.120664313607;1012.8581998520066;1060.9019664647053;1073;1094.0864378244096;1101.6694991502518;4552.544745525487;4623.884402889955;4629.976850115728;4681.531846815359;4681.625469962395;12405.379731013414;12632.873671263169;12742.745145097046;12745.490180392866;12750.681232969064;11701.882981170249;12148.392580370946;12195.695107622381;12496.937515312366;12776.808347874789;9180.31147663928;9264.675736349196;9273.211776998896;9283.350165488486;9284.118008789153;6406.9359306408205;6735.865282694416;6765;6848.794536163923;6894.069300644549;11301.604443844426;11344.149188810707;11411.429428528374;11559;11613.535458581562;11498.19512634141;11543.134264930331;11643.88356116462;11653.359065251154;11749.060075194135;7656.157822639617;8316.293115085286;8555.572221388782;8747.343949203709;8935.329850261387;9636.22910167199;9713.417194968324;9726.076022777825;9772.267079969173;9797.167240784329;8438.915610843813;8678.262347700516;8741;8762.518061506424;8829.646814127364;8377.790555236168;8383.874241886499;8385.28725058377;8437.873431898404;8606.913930860612;7492.887606685795;7518.962405187939;7519.736809211651;7618.08582970025;7639.579823109782;5313.6450205197425;5363.168708850135;5450.727463626724;5519.227308176939;5681.204631351697;5633.324001119892;5649.604527683187;5675.8864822704145;5704.515116215168;5788.0739081746715 02:47:22 INFO - PROCESS | 9526 | |4;prototype.html;349.2177522349936;354.1942081763987;355.8950109717633;356.71641045368926;362.0080978119952;5829.618821083772;5890.410958904107;5910.940890591093;5926.970365148179;5940.168376427304;5774.797882074128;5780.121460525325;5795.420457954203;5820.912686309709;5859.355470898197;4284.678649101322;4484.730916145026;4513.142502924434;4516.322551617251;4524.049949510607;4461.196984542781;4533.3426653135275;4545.681802273843;4554.223852697451;4594.150082234781;4472.485664148616;4522.9597192645715;4531.501534831166;4536.160810250114;4545.068261006486;4428;4450.888727781799;4466.598006179427;4474.261746811805;4504.932426013613;3915.805679267822;3935.232629637222;3939.113699417637;3949.763014219156;3961.2473630010495;5617.634853734494;5664.0937450007805;5679.716014199274;5688.800891968803;5692.146178073281;5059.2916991621205;5134.64057515974;5141.820036298712;5171.637985341028;5201.427842937273;6028.246469191351;6055.333913269536;6092.9695351523405;6107.206063211798;6114.908276375858;4217.514985776614;4318.632916202127;4321.200577893069;4367.192069467159;4410.669199809995;6168.414000669929;6267.4045965633195;6323.6521991290465;6349.9682501587195;6373.776917807854;4411.698548928074;4415.139047885631;4417.337399390053;4420.8673739787855;4440.600345968878;4481.7983190756495;4486.977565112219;4488.745659396976;4510.864674059783;4517.954820451753;4898.403845961646;5128.256402821645;5155.484451554815;5172.534471897472;5175.663581867167;6078.513718902477;6103.084537319349;6111.174991376108;6147.139400483936;6172.574221307217;1560.9219539023004;1560.9921950390176;1570.6780110077407;1573.6616627425158;1587.190532828266;956.7321150077989;994.8806143262855;999.6201443451587;1002.7766125327089;1015.9949200253951;5148.687084793353;5272.472752724697;5280.234366016906;5323.866903327448;5343.305370301836;5545.639533430314;5584.497395234448;5584.97207513968;5609.439056094439;5661.245014045577;5188.558972487305;5337.478818536699;5477.945220547823;6034.909476357858;6064.363241859542;3390.355832391887;3392;3395.2869897321343;3396.728261739055;3410.2838403935452;6318.831016262006;6539.50953678476;6572.474202063919;6598.95432415943;6614.669266536654;6413.839654008687;6427.967860160763;6460.709268082947;6492.577982431127;6501.1548498694865;6221.076094235612;6583.63789991555;6596.769113081019;6597.538172327987;6634.502412319095;6285.685715714105;6290.716917738804;6323.20959880015;6346.492280617632;6347.301796802256;5898.764049438146;6216.471599914058;6229.909765790878;6233.812985610439;6237.937620623918;6332.588381755171;6466.838329041811;6537.803865884031;6557.377049180321;6579.309172536815;4441.733495990251;4454.799534020912;4474.217012022948;4479.350494178391;4515.209838278222;6257.937420625917;6324.1146239527425;6351.888419526656;6380.712867921047;6384.425401713868;6099.176611157614;6151.753929842936;6163.753449861955;6168.9691551541955;6171.876562468636;5954.404559544011;6136.877262454636;6158.692065396802;6179.969100154471;6207.734177025443;6042.063480160582;6043.395660433922;6064.181335519648;6080.90878636812;6102.511799056154;6175.536834737502;6186.783462578788;6188.164597779242;6213.409726076015;6236.906446403398;5781.94218057814;6050.610009046314;6074.271087469532;6081.8175454734655;6100.908486372619 02:47:22 INFO - PROCESS | 9526 | |5;yui.html;788.7712563356627;799.0730752327302;841.9031811341696;891.2914233184617;895.9507227102507;15448;15486.535403937873;15523;15569.844301556981;16536.503904882844;15995.920020399912;16176.595585110379;16187.676246475094;16193.919030404832;16201.189940502987;735.2977906099688;865.312076898867;888.6800751729372;891.6834523744075;895.7357579514058;877.0308808766317;877.7673916412156;883.9513826739527;886.1492966751894;888.5690440136528;927.323054170456;933.1368484152166;933.8459154239542;934.9485778282192;935.5789894547447;918.1094338491653;923.5890028937125;927.9025702301296;928.0533855467386;929.5816882402946;679.3308591037824;680.2823021712092;682.2904179653154;684.1209046375434;687.1376422589668;15433.768493472608;15563.844361556467;15574.922125389301;15582.532524024298;15662.765058524132;15732.752156917682;16196.676066478722;16264.18679066042;16549.751753723704;16551.83448165515;12662;12799.104062715614;12810.615681529569;13036.739265214737;13131.803022954664;4216.7259128156875;4684.531546845323;4711.411073615798;4778.641601879873;4983.401991760976;79350;80371;80427;80521;80972.59513702453;12127.090468214743;12228.518641761377;12257.448414821354;12280.631581052583;12409.441575129142;21496.78503214979;21522;21540.461488462915;21670.891645541673;21674.24140155087;8480.151984801594;8701.086385929513;8870.42342247752;8872.911270887338;9003.864942025875;4852.102361063215;4865.805367785249;4922.064807686528;4950.480199578992;5162.328897243335;3771.7171212159196;3820.2932457495453;3829.7319187656594;3841.9807900960877;3855.479510266134;635.8601107756378;649.0264603095357;650.5543702563759;660.7753363856312;683.0983102305009;677.5223467455432;695.2317688953734;778.992210077892;780.508279783744;845.471580262336;11059.612913548148;11209.775804483865;11240.718982025352;11361.431928403546;11362.772744545064;792.834533236142;816.9346452283803;820.8153165537825;822.5147163173756;826.6982551368827;4853.611711063107;4909.77905994224;4948.4309304429735;5050.823221187241;5063.797448102108;71084;76273.23726762773;76599;76787.23212767912;83848;64367.35632643614;87355;94583.0541694588;100794.49602751939;100880.49559752154;88386.55806721054;89824.5508772452;90348;90961;92438.0756192443;9832.55753491109;9971.152452041657;10079.949600251952;10087.193024558164;10138.746531336776;55482.72258638681;55750;55914.44085559255;56000.719996399755;57787;78138.21861781536;79530.6023469879;80895;81013;81140.59429702813;12806.167599106027;12809.487620495449;12864.421101050288;13083.738325233251;13176.275304858325;14297.499587514387;14455.13269203851;14502.274886255434;14690;15138.318775655342;13491.662708432368;13636.977226707839;13900.51348202808;14147.787783183467;14214.005019648524;13091.803622945854;13276.070675052653;13438.664033398853;14441.855581444051;14473.059251148641;13194.604161875159;13360.665983350495;13704.52034178799;13954.162750234613;14009.299535023412;10752.784944300915;10825.188110891871;11073.335599864035;11320.320780753182;11335.093192544411;11246.550137994389;11260.718482038015;11329;11438.656840294805;11475.655730328104 02:47:22 INFO - PROCESS | 9526 | __end_tp_report 02:47:22 INFO - PROCESS | 9526 | __start_cc_report 02:47:22 INFO - PROCESS | 9526 | _x_x_mozilla_cycle_collect,351 02:47:22 INFO - PROCESS | 9526 | __end_cc_report 02:47:22 INFO - PROCESS | 9526 | __startTimestamp1465292842153__endTimestamp 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | ------- Summary: start ------- 02:47:22 INFO - PROCESS | 9526 | Number of tests: 6 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | [#0] dojo.html Cycles:165 Average:5778.78 Median:6012.76 stddev:661.43 (11.0%) stddev-sans-first:633.34 02:47:22 INFO - PROCESS | 9526 | Values: 3263.5 3309.4 3411.6 3433.9 3438.4 5748.3 5792.4 5804.2 5826.7 5850.6 5812.7 5862.5 5881.8 5887.5 5902.5 5200.3 5275.0 5309.9 5327.5 5369.3 5187.4 5189.7 5353.8 5364.4 5389.4 5223.2 5301.2 5304.7 5333.2 5336.1 5368.8 5382.8 5386.9 5420.0 5422.6 5102.7 5184.6 5225.4 5301.9 5351.6 5675.5 5732.5 5734.3 5773.4 5800.3 6269.6 6292.6 6292.9 6295.1 6315.8 6082.8 6100.9 6114.8 6339.7 6362.0 5814.4 5814.7 5824.1 5836.9 5843.6 6333.4 6341.9 6362.3 6365.6 6375.5 5886.6 6009.9 6018.5 6069.6 6073.8 6216.6 6218.4 6219.9 6232.5 6251.7 6134.5 6172.3 6189.9 6199.7 6223.2 5957.8 6067.3 6100.9 6118.4 6165.7 4709.9 4710.3 4713.5 4725.1 4754.0 4127.5 4211.7 4225.1 4225.5 4241.0 5759.6 5877.3 5889.2 5892.0 5928.1 6169.3 6180.4 6227.8 6269.6 6276.1 5799.6 5985.7 5988.0 6024.3 6034.8 5308.9 5334.3 5343.2 5347.5 5375.8 6458.3 6469.8 6475.0 6500.9 6513.7 6034.3 6132.4 6246.5 6257.6 6260.7 6414.6 6528.5 6530.5 6538.7 6543.9 6092.5 6166.3 6170.0 6170.8 6194.8 6030.5 6193.5 6253.5 6296.9 6298.9 6114.4 6162.2 6174.0 6177.8 6180.8 6142.4 6152.8 6153.2 6167.2 6176.1 5777.7 5859.8 5881.7 5912.6 6037.8 6048.5 6085.3 6094.6 6102.9 6132.0 6007.8 6012.7 6012.8 6021.4 6021.5 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | [#1] ext.html Cycles:180 Average:64624.61 Median:43692.95 stddev:129719.83 (296.9%) stddev-sans-first:129994.60 02:47:22 INFO - PROCESS | 9526 | Values: 577.3 638.6 648.6 659.4 661.6 47817.0 48951.8 49451.8 49623.0 52528.5 48225.3 48618.8 48901.3 48928.8 48936.0 9024.6 9196.2 9200.3 9216.3 9217.4 9153.3 9184.4 9187.9 9192.2 9214.3 9319.1 9322.7 9364.8 9369.4 9372.2 9193.1 9225.5 9232.6 9243.4 9297.3 9115.3 9174.2 9189.7 9249.5 9255.4 45523.5 45596.0 45917.5 46046.1 46154.8 3593.2 3751.8 4261.9 4441.6 4453.8 32757.0 32993.0 33040.0 33310.2 34602.1 4731.6 4757.9 4775.5 4780.6 4798.5 375164.1 375490.0 376947.0 377059.0 378447.0 66985.0 67007.0 67217.0 67305.7 67448.0 40694.4 41064.2 41513.0 43141.8 43186.1 17625.8 17839.6 17868.9 17883.0 17890.2 14248.6 14285.6 14287.0 14387.9 14425.6 22134.9 22153.8 22240.8 22250.7 22288.9 7626.3 7653.3 7675.5 7737.9 7905.3 1019.4 1063.1 1143.7 1146.9 1229.1 33885.0 33981.5 34011.8 34356.5 34884.3 1170.2 1192.3 1232.3 1241.5 1250.9 17913.7 17976.6 18038.8 18198.8 18330.1 544908.0 620761.0 644379.0 654785.0 656555.0 64390.7 64879.4 65347.0 65585.7 65638.0 1443.0 1449.2 1451.9 1453.5 1461.9 32612.3 32963.0 33129.8 33551.8 34013.5 54715.7 55211.2 55368.0 55438.0 55561.0 422122.0 426204.0 426920.0 427895.0 428424.0 30991.7 31122.0 31359.7 31369.2 31386.4 50040.5 50409.5 50639.2 51029.0 51649.7 42096.6 43642.6 43659.8 43861.3 44306.8 43461.0 43519.6 43726.1 43916.1 44179.1 42695.1 42860.6 42918.0 45305.5 46204.3 39665.0 40379.0 40769.0 41551.4 41979.4 30347.8 30485.2 31162.2 31205.1 31408.0 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | [#2] jquery.html Cycles:180 Average:29339.51 Median:11523.00 stddev:79575.52 (690.6%) stddev-sans-first:79769.12 02:47:22 INFO - PROCESS | 9526 | Values: 419.8 425.9 429.9 434.7 442.2 18750.3 19843.8 20451.4 20839.8 20848.8 19148.2 19856.9 20169.9 20942.7 21053.9 5786.7 5962.2 5983.0 5993.6 6000.6 5738.9 5741.5 5751.5 5886.9 5934.4 5695.5 5743.5 5760.8 5771.7 5790.9 5637.7 5764.9 5765.2 5974.8 5985.5 5737.7 5820.7 5842.7 5884.8 5937.9 14703.7 14943.9 15111.1 15250.3 15253.1 2391.6 2468.2 2468.8 2481.2 2532.6 11319.0 11323.2 11366.6 11423.8 14701.0 2077.5 2090.9 2132.7 2139.4 2185.0 54665.7 76497.2 91553.5 92793.5 93838.5 10740.6 10880.6 10969.6 11166.2 11277.6 15157.2 15297.1 15358.7 15514.8 15595.9 7918.0 7924.0 8433.1 8562.1 8666.7 8497.7 8602.9 8736.7 8740.6 8836.2 4726.3 4840.1 4896.6 4956.2 5021.3 2103.3 2120.8 2137.8 2152.0 2176.7 1027.5 1052.7 1085.9 1095.8 1193.8 18532.4 19343.7 19376.3 20389.0 20433.0 1048.0 1053.4 1058.0 1076.8 1107.3 10847.7 11289.3 11300.7 11327.9 11405.8 472178.0 474971.0 478641.0 483937.0 488814.0 100790.0 103788.5 103992.0 107012.0 107557.5 1068.8 1096.5 1105.7 1105.9 1116.1 17710.2 17909.2 17996.5 18164.0 18170.5 30109.0 44725.6 44893.6 45019.8 46826.0 63561.7 64092.0 64641.0 65116.3 65469.3 8752.6 8828.9 8982.4 8998.4 9471.0 10634.5 12904.8 13227.9 13288.5 14167.8 11896.2 11992.2 12037.2 12144.9 12195.8 11677.3 11687.0 11995.6 12291.3 12428.8 12103.5 12186.8 12194.2 12195.8 12333.6 8684.2 8748.2 8987.6 9025.8 9037.8 11619.9 11865.0 11962.0 12000.3 12269.3 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | [#3] mootools.html Cycles:180 Average:6465.40 Median:4626.93 stddev:3775.75 (81.6%) stddev-sans-first:3768.91 02:47:22 INFO - PROCESS | 9526 | Values: 1637.5 1648.8 1880.0 1943.1 1955.2 8530.6 8937.7 9519.7 9545.6 9602.1 9614.0 9892.3 10005.5 10017.4 10018.4 2495.2 2508.3 2526.9 2534.8 2539.6 2479.0 2542.4 2551.8 2555.6 2555.7 2500.1 2500.3 2546.4 2551.6 2557.5 2381.7 2382.2 2400.5 2411.0 2432.6 2359.2 2400.0 2410.6 2412.1 2418.3 9824.4 9853.3 9902.0 9908.5 9917.2 5828.5 5913.8 5930.9 5939.5 5979.6 3701.5 3779.6 3876.7 3889.2 3907.9 1177.1 1204.0 1215.6 1237.8 1267.1 14330.5 14344.6 14411.8 14464.4 14494.3 5090.5 5122.9 5320.6 5332.5 5415.9 11111.3 11188.3 11206.4 11219.6 11248.8 5861.2 5865.8 5866.4 5885.4 5891.9 4857.2 5394.2 5433.2 5486.0 5492.8 3953.3 3957.3 3959.8 4016.2 4071.7 1180.5 1220.2 1230.9 1242.3 1244.0 890.7 905.5 934.6 967.0 1019.2 6373.5 6677.1 6679.2 6763.1 6764.1 1012.9 1060.9 1073.0 1094.1 1101.7 4552.5 4623.9 4630.0 4681.5 4681.6 12405.4 12632.9 12742.7 12745.5 12750.7 11701.9 12148.4 12195.7 12496.9 12776.8 9180.3 9264.7 9273.2 9283.4 9284.1 6406.9 6735.9 6765.0 6848.8 6894.1 11301.6 11344.1 11411.4 11559.0 11613.5 11498.2 11543.1 11643.9 11653.4 11749.1 7656.2 8316.3 8555.6 8747.3 8935.3 9636.2 9713.4 9726.1 9772.3 9797.2 8438.9 8678.3 8741.0 8762.5 8829.6 8377.8 8383.9 8385.3 8437.9 8606.9 7492.9 7519.0 7519.7 7618.1 7639.6 5313.6 5363.2 5450.7 5519.2 5681.2 5633.3 5649.6 5675.9 5704.5 5788.1 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | [#4] prototype.html Cycles:180 Average:5110.34 Median:5777.46 stddev:1515.52 (26.2%) stddev-sans-first:1477.04 02:47:22 INFO - PROCESS | 9526 | Values: 349.2 354.2 355.9 356.7 362.0 5829.6 5890.4 5910.9 5927.0 5940.2 5774.8 5780.1 5795.4 5820.9 5859.4 4284.7 4484.7 4513.1 4516.3 4524.0 4461.2 4533.3 4545.7 4554.2 4594.2 4472.5 4523.0 4531.5 4536.2 4545.1 4428.0 4450.9 4466.6 4474.3 4504.9 3915.8 3935.2 3939.1 3949.8 3961.2 5617.6 5664.1 5679.7 5688.8 5692.1 5059.3 5134.6 5141.8 5171.6 5201.4 6028.2 6055.3 6093.0 6107.2 6114.9 4217.5 4318.6 4321.2 4367.2 4410.7 6168.4 6267.4 6323.7 6350.0 6373.8 4411.7 4415.1 4417.3 4420.9 4440.6 4481.8 4487.0 4488.7 4510.9 4518.0 4898.4 5128.3 5155.5 5172.5 5175.7 6078.5 6103.1 6111.2 6147.1 6172.6 1560.9 1561.0 1570.7 1573.7 1587.2 956.7 994.9 999.6 1002.8 1016.0 5148.7 5272.5 5280.2 5323.9 5343.3 5545.6 5584.5 5585.0 5609.4 5661.2 5188.6 5337.5 5477.9 6034.9 6064.4 3390.4 3392.0 3395.3 3396.7 3410.3 6318.8 6539.5 6572.5 6599.0 6614.7 6413.8 6428.0 6460.7 6492.6 6501.2 6221.1 6583.6 6596.8 6597.5 6634.5 6285.7 6290.7 6323.2 6346.5 6347.3 5898.8 6216.5 6229.9 6233.8 6237.9 6332.6 6466.8 6537.8 6557.4 6579.3 4441.7 4454.8 4474.2 4479.4 4515.2 6257.9 6324.1 6351.9 6380.7 6384.4 6099.2 6151.8 6163.8 6169.0 6171.9 5954.4 6136.9 6158.7 6180.0 6207.7 6042.1 6043.4 6064.2 6080.9 6102.5 6175.5 6186.8 6188.2 6213.4 6236.9 5781.9 6050.6 6074.3 6081.8 6100.9 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - PROCESS | 9526 | [#5] yui.html Cycles:180 Average:20306.75 Median:4859.71 stddev:27411.66 (564.1%) stddev-sans-first:27449.38 02:47:22 INFO - PROCESS | 9526 | Values: 788.8 799.1 841.9 891.3 896.0 15448.0 15486.5 15523.0 15569.8 16536.5 15995.9 16176.6 16187.7 16193.9 16201.2 735.3 865.3 888.7 891.7 895.7 877.0 877.8 884.0 886.1 888.6 927.3 933.1 933.8 934.9 935.6 918.1 923.6 927.9 928.1 929.6 679.3 680.3 682.3 684.1 687.1 15433.8 15563.8 15574.9 15582.5 15662.8 15732.8 16196.7 16264.2 16549.8 16551.8 12662.0 12799.1 12810.6 13036.7 13131.8 4216.7 4684.5 4711.4 4778.6 4983.4 79350.0 80371.0 80427.0 80521.0 80972.6 12127.1 12228.5 12257.4 12280.6 12409.4 21496.8 21522.0 21540.5 21670.9 21674.2 8480.2 8701.1 8870.4 8872.9 9003.9 4852.1 4865.8 4922.1 4950.5 5162.3 3771.7 3820.3 3829.7 3842.0 3855.5 635.9 649.0 650.6 660.8 683.1 677.5 695.2 779.0 780.5 845.5 11059.6 11209.8 11240.7 11361.4 11362.8 792.8 816.9 820.8 822.5 826.7 4853.6 4909.8 4948.4 5050.8 5063.8 71084.0 76273.2 76599.0 76787.2 83848.0 64367.4 87355.0 94583.1 100794.5 100880.5 88386.6 89824.6 90348.0 90961.0 92438.1 9832.6 9971.2 10079.9 10087.2 10138.7 55482.7 55750.0 55914.4 56000.7 57787.0 78138.2 79530.6 80895.0 81013.0 81140.6 12806.2 12809.5 12864.4 13083.7 13176.3 14297.5 14455.1 14502.3 14690.0 15138.3 13491.7 13637.0 13900.5 14147.8 14214.0 13091.8 13276.1 13438.7 14441.9 14473.1 13194.6 13360.7 13704.5 13954.2 14009.3 10752.8 10825.2 11073.3 11320.3 11335.1 11246.6 11260.7 11329.0 11438.7 11475.7 02:47:22 INFO - PROCESS | 9526 | -------- Summary: end -------- 02:47:22 INFO - PROCESS | 9526 | 02:47:22 INFO - TEST-INFO | 9526: exit 0 02:47:22 INFO - TEST-OK | dromaeo_css | took 1110437ms 02:47:22 INFO - TEST-START | kraken 02:47:22 INFO - operating with platform_type : linux_ 02:47:22 INFO - Initialising browser for kraken test... 02:47:22 INFO - TEST-INFO | started process 9769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSyPYQ/profile http://localhost:41147/getInfo.html) 02:47:27 INFO - PROCESS | 9769 | __metrics Screen width/height:1600/1200 02:47:27 INFO - PROCESS | 9769 | colorDepth:24 02:47:27 INFO - PROCESS | 9769 | Browser inner width/height: 1024/697 02:47:27 INFO - PROCESS | 9769 | __metrics 02:47:28 ERROR - PROCESS | 9769 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 02:47:28 INFO - TEST-INFO | 9769: exit 0 02:47:28 INFO - Browser initialized. 02:47:28 INFO - Running cycle 1/1 for kraken test... 02:47:28 INFO - TEST-INFO | started process 9898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSyPYQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:40 INFO - PROCESS | 9898 | RSS: Main: 156033024 02:47:40 INFO - PROCESS | 9898 | 02:47:43 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41147/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:43 INFO - PROCESS | 9898 | RSS: Main: 161308672 02:47:43 INFO - PROCESS | 9898 | 02:47:46 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41147/tests/kraken/driver.html?testName=audio-dft) 02:47:47 INFO - PROCESS | 9898 | RSS: Main: 160415744 02:47:47 INFO - PROCESS | 9898 | 02:47:50 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41147/tests/kraken/driver.html?testName=audio-fft) 02:47:50 INFO - PROCESS | 9898 | RSS: Main: 161443840 02:47:50 INFO - PROCESS | 9898 | 02:47:52 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41147/tests/kraken/driver.html?testName=audio-oscillator) 02:47:53 INFO - PROCESS | 9898 | RSS: Main: 161308672 02:47:53 INFO - PROCESS | 9898 | 02:47:55 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:56 INFO - PROCESS | 9898 | RSS: Main: 160919552 02:47:56 INFO - PROCESS | 9898 | 02:47:59 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41147/tests/kraken/driver.html?testName=imaging-darkroom) 02:47:59 INFO - PROCESS | 9898 | RSS: Main: 160632832 02:47:59 INFO - PROCESS | 9898 | 02:48:03 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41147/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:03 INFO - PROCESS | 9898 | RSS: Main: 161071104 02:48:03 INFO - PROCESS | 9898 | 02:48:06 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41147/tests/kraken/driver.html?testName=json-parse-financial) 02:48:07 INFO - PROCESS | 9898 | RSS: Main: 161021952 02:48:07 INFO - PROCESS | 9898 | 02:48:08 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:09 INFO - PROCESS | 9898 | RSS: Main: 160743424 02:48:09 INFO - PROCESS | 9898 | 02:48:11 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:11 INFO - PROCESS | 9898 | RSS: Main: 160501760 02:48:11 INFO - PROCESS | 9898 | 02:48:14 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:14 INFO - PROCESS | 9898 | RSS: Main: 161046528 02:48:14 INFO - PROCESS | 9898 | 02:48:17 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:17 INFO - PROCESS | 9898 | RSS: Main: 161185792 02:48:17 INFO - PROCESS | 9898 | 02:48:20 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:21 INFO - PROCESS | 9898 | RSS: Main: 160980992 02:48:21 INFO - PROCESS | 9898 | 02:48:22 INFO - PROCESS | 9898 | Cycle 1(1): loaded http://localhost:41147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41147/tests/kraken/driver.html?testName=ai-astar) 02:48:23 INFO - PROCESS | 9898 | RSS: Main: 161808384 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | __start_tp_report 02:48:23 INFO - PROCESS | 9898 | _x_x_mozilla_page_load 02:48:23 INFO - PROCESS | 9898 | _x_x_mozilla_page_load_details 02:48:23 INFO - PROCESS | 9898 | |i|pagename|runs| 02:48:23 INFO - PROCESS | 9898 | |0;ai-astar;110;105;111;111;113;111;110;110;111;112 02:48:23 INFO - PROCESS | 9898 | |1;audio-beat-detection;160;130;149;178;137;152;152;126;201;134 02:48:23 INFO - PROCESS | 9898 | |2;audio-dft;162;162;163;162;163;163;160;162;162;162 02:48:23 INFO - PROCESS | 9898 | |3;audio-fft;74;75;76;170;75;75;75;76;163;77 02:48:23 INFO - PROCESS | 9898 | |4;audio-oscillator;83;86;147;85;86;85;143;85;84;140 02:48:23 INFO - PROCESS | 9898 | |5;imaging-gaussian-blur;117;117;118;116;118;117;117;117;118;118 02:48:23 INFO - PROCESS | 9898 | |6;imaging-darkroom;146;150;148;147;148;150;147;155;146;146 02:48:23 INFO - PROCESS | 9898 | |7;imaging-desaturate;96;95;105;95;99;95;96;95;95;94 02:48:23 INFO - PROCESS | 9898 | |8;json-parse-financial;53;52;53;53;54;55;58;53;55;53 02:48:23 INFO - PROCESS | 9898 | |9;json-stringify-tinderbox;59;60;60;59;59;58;59;59;60;59 02:48:23 INFO - PROCESS | 9898 | |10;stanford-crypto-aes;77;76;75;76;77;77;77;78;105;83 02:48:23 INFO - PROCESS | 9898 | |11;stanford-crypto-ccm;128;120;127;118;120;126;129;132;124;133 02:48:23 INFO - PROCESS | 9898 | |12;stanford-crypto-pbkdf2;162;153;158;155;158;152;154;154;154;153 02:48:23 INFO - PROCESS | 9898 | |13;stanford-crypto-sha256-iterative;62;63;64;63;63;61;61;62;63;61 02:48:23 INFO - PROCESS | 9898 | __end_tp_report 02:48:23 INFO - PROCESS | 9898 | __start_cc_report 02:48:23 INFO - PROCESS | 9898 | _x_x_mozilla_cycle_collect,855 02:48:23 INFO - PROCESS | 9898 | __end_cc_report 02:48:23 INFO - PROCESS | 9898 | __startTimestamp1465292903038__endTimestamp 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | ------- Summary: start ------- 02:48:23 INFO - PROCESS | 9898 | Number of tests: 14 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 02:48:23 INFO - PROCESS | 9898 | Values: 110.0 105.0 111.0 111.0 113.0 111.0 110.0 110.0 111.0 112.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:152.00 stddev:23.24 (15.3%) stddev-sans-first:24.46 02:48:23 INFO - PROCESS | 9898 | Values: 160.0 130.0 149.0 178.0 137.0 152.0 152.0 126.0 201.0 134.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 02:48:23 INFO - PROCESS | 9898 | Values: 162.0 162.0 163.0 162.0 163.0 163.0 160.0 162.0 162.0 162.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:38.47 (51.3%) stddev-sans-first:40.14 02:48:23 INFO - PROCESS | 9898 | Values: 74.0 75.0 76.0 170.0 75.0 75.0 75.0 76.0 163.0 77.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.00 stddev:28.31 (33.3%) stddev-sans-first:29.14 02:48:23 INFO - PROCESS | 9898 | Values: 83.0 86.0 147.0 85.0 86.0 85.0 143.0 85.0 84.0 140.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 02:48:23 INFO - PROCESS | 9898 | Values: 117.0 117.0 118.0 116.0 118.0 117.0 117.0 117.0 118.0 118.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:2.79 (1.9%) stddev-sans-first:2.83 02:48:23 INFO - PROCESS | 9898 | Values: 146.0 150.0 148.0 147.0 148.0 150.0 147.0 155.0 146.0 146.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:95.00 stddev:3.27 (3.4%) stddev-sans-first:3.47 02:48:23 INFO - PROCESS | 9898 | Values: 96.0 95.0 105.0 95.0 99.0 95.0 96.0 95.0 95.0 94.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:1.73 (3.2%) stddev-sans-first:1.80 02:48:23 INFO - PROCESS | 9898 | Values: 53.0 52.0 53.0 53.0 54.0 55.0 58.0 53.0 55.0 53.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 02:48:23 INFO - PROCESS | 9898 | Values: 59.0 60.0 60.0 59.0 59.0 58.0 59.0 59.0 60.0 59.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:77.00 stddev:9.01 (11.7%) stddev-sans-first:9.49 02:48:23 INFO - PROCESS | 9898 | Values: 77.0 76.0 75.0 76.0 77.0 77.0 77.0 78.0 105.0 83.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:127.50 stddev:5.14 (4.0%) stddev-sans-first:5.39 02:48:23 INFO - PROCESS | 9898 | Values: 128.0 120.0 127.0 118.0 120.0 126.0 129.0 132.0 124.0 133.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:154.50 stddev:3.09 (2.0%) stddev-sans-first:2.13 02:48:23 INFO - PROCESS | 9898 | Values: 162.0 153.0 158.0 155.0 158.0 152.0 154.0 154.0 154.0 153.0 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - PROCESS | 9898 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 02:48:23 INFO - PROCESS | 9898 | Values: 62.0 63.0 64.0 63.0 63.0 61.0 61.0 62.0 63.0 61.0 02:48:23 INFO - PROCESS | 9898 | -------- Summary: end -------- 02:48:23 INFO - PROCESS | 9898 | 02:48:23 INFO - TEST-INFO | 9898: exit 0 02:48:23 INFO - TEST-OK | kraken | took 61147ms 02:48:23 INFO - SUITE-END | took 1171s 02:48:24 INFO - Completed test suite (00:19:31) 02:48:24 INFO - javascript benchmark 02:48:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7765.515375446133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.4615288477403, 3309.437395642741, 3411.607665118512, 3433.914152146196, 3438.381091403548, 5748.281464816898, 5792.391798861122, 5804.187413762077, 5826.679532625704, 5850.5612079094135, 5812.709364531767, 5862.472377486026, 5881.764729410818, 5887.499562537189, 5902.527797776178, 5200.32395788547, 5275.0, 5309.867253318678, 5327.493888080626, 5369.275147855029, 5187.4034486034025, 5189.7405129743365, 5353.7590808413715, 5364.356277246736, 5389.407165211824, 5223.242629818674, 5301.1783173608155, 5304.734763261841, 5333.226682131089, 5336.066188417031, 5368.8389348319615, 5382.838514844561, 5386.946130538684, 5419.972900135494, 5422.6475279106735, 5102.668326558762, 5184.5593124584075, 5225.425203227642, 5301.893962120775, 5351.598630102758, 5675.460831221028, 5732.541396688297, 5734.340550836666, 5773.39379365169, 5800.274965629296, 6269.62382257066, 6292.5595208335435, 6292.905606415908, 6295.118683384284, 6315.778947736807, 6082.847928801771, 6100.877982440371, 6114.844865410725, 6339.651319177444, 6362.0456931460185, 5814.418558144152, 5814.680192589448, 5824.068149096124, 5836.88326233473, 5843.649381037151, 6333.36666333363, 6341.904871426932, 6362.300146983828, 6365.586236894587, 6375.489960803125, 5886.646801191942, 6009.939900601025, 6018.548608854353, 6069.605475644069, 6073.848153796102, 6216.5605095541405, 6218.378162183836, 6219.906701399483, 6232.501399887998, 6251.718672659741, 6134.478569321568, 6172.290186628506, 6189.907151392733, 6199.690015499207, 6223.222097237845, 5957.821265362046, 6067.332593414721, 6100.8779824404155, 6118.418750218722, 6165.724445154671, 4709.905801883943, 4710.293455981561, 4713.457952335457, 4725.102230576248, 4754.02542478791, 4127.463429754112, 4211.663066954637, 4225.070484493406, 4225.492940847118, 4240.957590424118, 5759.625624334489, 5877.265341832271, 5889.204957330791, 5891.970540147272, 5928.110783382527, 6169.321374648785, 6180.443760061616, 6227.750889964351, 6269.592476489013, 6276.1213430118905, 5799.594028418054, 5985.670788106696, 5988.041913293852, 6024.324216728404, 6034.758609655652, 5308.92036619451, 5334.306540149756, 5343.171808369709, 5347.465253474621, 5375.838724838261, 6458.2895881453005, 6469.805905822833, 6475.0, 6500.9349906501275, 6513.73945042193, 6034.306054803754, 6132.447291485866, 6246.46905013079, 6257.5932564383165, 6260.655663938527, 6414.647194404352, 6528.510361722985, 6530.47756179495, 6538.705758240795, 6543.869122617426, 6092.45167934888, 6166.2600487939935, 6170.043643235305, 6170.753169873155, 6194.783182588588, 6030.517558595214, 6193.535484838565, 6253.530985176221, 6296.937030629635, 6298.874022519615, 6114.357992410733, 6162.198914141133, 6174.043023331391, 6177.81466556004, 6180.783672571439, 6142.41647043548, 6152.846178845564, 6153.2000839890525, 6167.167432396748, 6176.073588961692, 5777.6822274775295, 5859.765609375577, 5881.735321910439, 5912.556558258062, 6037.818865434044, 6048.5161187105805, 6085.330613632408, 6094.573379863367, 6102.938970610237, 6132.049532322497, 6007.8197654070445, 6012.6993650316435, 6012.759489620366, 6021.367756385516, 6021.548383871314], "value": 5733.796755639633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2611057845957, 638.5944924972642, 648.6400047973373, 659.3538332434217, 661.5633681770031, 47817.0, 48951.75524122384, 49451.75274123625, 49623.0, 52528.47471525293, 48225.27662085072, 48618.75690621551, 48901.266481002815, 48928.75535622317, 48936.0, 9024.593893274818, 9196.218321442686, 9200.263978881707, 9216.262698984065, 9217.400868943498, 9153.313501487382, 9184.448933064037, 9187.908120918806, 9192.172704456598, 9214.262858971266, 9319.114684105, 9322.720318390458, 9364.765880852965, 9369.390989585689, 9372.156505914467, 9193.08069193082, 9225.492597907112, 9232.6306947722, 9243.352965292432, 9297.302702297355, 9115.316351273616, 9174.174324310845, 9189.724308270763, 9249.491277979709, 9255.352125351228, 45523.54476455226, 45596.0, 45917.54082459166, 46046.07907841858, 46154.76922615366, 3593.2274560969254, 3751.8311675974646, 4261.87214383569, 4441.578050085237, 4453.821847126143, 32757.0, 32993.0, 33040.0, 33310.167245818804, 34602.13494662628, 4731.621470282369, 4757.857264282043, 4775.498572649856, 4780.569748722632, 4798.49615790344, 375164.1241793801, 375490.0, 376947.0, 377059.0, 378447.0, 66985.0, 67007.0, 67217.0, 67305.66347168233, 67448.0, 40694.38958415626, 41064.17871642551, 41513.0, 43141.784291078344, 43186.13627727428, 17625.823741762673, 17839.554011149827, 17868.910655446638, 17883.0, 17890.194941227677, 14248.572542823731, 14285.57143285703, 14287.0, 14387.856121438652, 14425.567232983027, 22134.88932555359, 22153.77846221517, 22240.777592224193, 22250.666240006412, 22288.88855555744, 7626.313631773167, 7653.3494652954005, 7675.462717609826, 7737.922620773833, 7905.328047115944, 1019.3883669798062, 1063.0963680871353, 1143.6854864912216, 1146.8795776443353, 1229.0843321725372, 33885.0, 33981.490277645855, 34011.82994085014, 34356.48465273023, 34884.30231395409, 1170.2042611024585, 1192.2786714038054, 1232.3160645841645, 1241.4661695470854, 1250.8936740376987, 17913.7312940306, 17976.640467190846, 18038.819611803978, 18198.818011819978, 18330.083495825424, 544908.0, 620761.0, 644379.0, 654785.0, 656555.0, 64390.678046609464, 64879.351206488274, 65347.0, 65585.67207164029, 65638.0, 1442.985570144285, 1449.2319370368134, 1451.8765904898203, 1453.4840131753076, 1461.8611231933162, 32612.34775304433, 32963.0, 33129.83435082809, 33551.83224083961, 34013.48979765256, 54715.72642136764, 55211.17183242174, 55368.0, 55438.0, 55561.0, 422122.0, 426204.0, 426920.0, 427895.0, 428424.0, 30991.690083099784, 31122.0, 31359.686403135678, 31369.21576960503, 31386.372272553963, 50040.49959500358, 50409.49590504048, 50639.240411394596, 51029.0, 51649.741751291, 42096.57903421049, 43642.56357436512, 43659.78170109129, 43861.34207986819, 44306.77846610746, 43461.0, 43519.564804351554, 43726.12547749091, 43916.12167756691, 44179.116417670826, 42695.146097078505, 42860.571394286904, 42918.0, 45305.54694453145, 46204.306935395325, 39665.0, 40379.0, 40769.0, 41551.37672934848, 41979.37030944599, 30347.848260758554, 30485.23786905345, 31162.22094447657, 31205.063848084596, 31408.0], "value": 21509.774712419337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.7796157017567, 425.88288220739304, 429.9462567179103, 434.68485348122596, 442.2040327410662, 18750.343737969157, 19843.801561984375, 20451.386458406254, 20839.791602084013, 20848.791512084874, 19148.234070637194, 19856.900715496402, 20169.890656013915, 20942.685859712077, 21053.894730526325, 5786.68173250471, 5962.195103661015, 5983.042713165894, 5993.550483713717, 6000.639961602296, 5738.913916291259, 5741.454561816641, 5751.453611906883, 5886.911696324559, 5934.376890426508, 5695.487406133468, 5743.4543718346695, 5760.798372056979, 5771.653700777946, 5790.884182316351, 5637.746301416426, 5764.884702305952, 5765.192872997763, 5974.820755377345, 5985.4912332451795, 5737.655740655532, 5820.708964551798, 5842.678652674102, 5884.823455296348, 5937.910931336033, 14703.705925881422, 14943.925280373638, 15111.093334399971, 15250.313735881911, 15253.08481491103, 2391.6053851114543, 2468.2101727447225, 2468.827182097254, 2481.2184161988916, 2532.632768248612, 11319.0, 11323.150763692756, 11366.602168924048, 11423.828642570368, 14701.0, 2077.480629842539, 2090.8918273315167, 2132.7227460430045, 2139.422355963881, 2185.0276626900877, 54665.726671366785, 76497.23502764957, 91553.54223228908, 92793.5360323194, 93838.53080734552, 10740.570377184982, 10880.572619624792, 10969.616063437901, 11166.218364714554, 11277.605283815026, 15157.166355850313, 15297.082175069532, 15358.692826143639, 15514.767278490832, 15595.922020389826, 7917.970663813782, 7923.9603801981775, 8433.072362040171, 8562.100979397073, 8666.653333866701, 8497.70258040978, 8602.87095693565, 8736.694215702548, 8740.562971851383, 8836.160564746468, 4726.314684370747, 4840.080384726891, 4896.559309662148, 4956.231784073474, 5021.271915572222, 2103.3059090500096, 2120.8091271785615, 2137.7648458669532, 2151.978480215209, 2176.6952626632283, 1027.527337424793, 1052.6789329254498, 1085.9294145880492, 1095.775366049958, 1193.797054500737, 18532.351367702067, 19343.709844352346, 19376.321828735927, 20388.96110388949, 20433.0, 1047.9633212837514, 1053.4364115198332, 1057.984130238047, 1076.7738774857212, 1107.341132026443, 10847.67456976292, 11289.322640641587, 11300.660980170607, 11327.943360283145, 11405.828912566318, 472178.0, 474971.0, 478641.0, 483937.0, 488814.0, 100790.0, 103788.48105759574, 103992.0, 107012.0, 107557.46221268844, 1068.8076146293586, 1096.4627332606965, 1105.6682995101598, 1105.9170562207867, 1116.0903863351343, 17710.203040862936, 17909.19408626641, 17996.460106196835, 18164.0, 18170.45488635343, 30109.0, 44725.55274447344, 44893.551064490246, 45019.77490112528, 46826.0, 63561.6821915906, 64092.0, 64641.0, 65116.34883651103, 65469.34530654823, 8752.649894004424, 8828.867566986628, 8982.371234013817, 8998.370114091951, 9471.0, 10634.52144653508, 12904.8064279034, 13227.867721322664, 13288.468461261828, 14167.787483187554, 11896.167268291483, 11992.160548761853, 12037.217580857216, 12144.939275303566, 12195.75608487843, 11677.299362038304, 11687.0, 11995.64013079609, 12291.262524248574, 12428.813567796671, 12103.515859365527, 12186.817197741864, 12194.207376520499, 12195.75608487843, 12333.62999110028, 8684.2184203422, 8748.212660860552, 8987.640494380152, 9025.819483610423, 9037.77405564866, 11619.941900290445, 11865.0, 11962.043036557228, 12000.279983201035, 12269.325187114437], "value": 9533.558000717656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1637.5169325049112, 1648.8103868055173, 1879.9812001879977, 1943.0964601460337, 1955.1690531524098, 8530.616122274498, 8937.704032915231, 9519.666811661593, 9545.57044932978, 9602.087801658849, 9613.951930240357, 9892.258080643944, 10005.499725013757, 10017.398956062623, 10018.398896066241, 2495.226479791266, 2508.3352911478473, 2526.9241922742253, 2534.809889258304, 2539.6317533957567, 2478.9752102478924, 2542.4025354041787, 2551.8213725039254, 2555.565553855849, 2555.6933168019773, 2500.087468074158, 2500.299916023507, 2546.401595625027, 2551.6045013023013, 2557.4501482181327, 2381.7022872140983, 2382.201962342617, 2400.543896659629, 2410.963835542468, 2432.574299497581, 2359.2332491940015, 2400.0, 2410.6384042393606, 2412.1316326122583, 2418.3470462975074, 9824.361416507976, 9853.310268281222, 9902.0, 9908.455034973074, 9917.206623470105, 5828.533717302648, 5913.822585322448, 5930.911036334458, 5939.465448109648, 5979.641221526722, 3701.5188025556504, 3779.622037796226, 3876.7286289959716, 3889.2221555688693, 3907.9218415631813, 1177.0818761366063, 1204.0, 1215.6353094071744, 1237.7586370657725, 1267.1256832785348, 14330.49843255481, 14344.56966291013, 14411.78382324266, 14464.421423143061, 14494.275286235646, 5090.541851233407, 5122.874007286934, 5320.627556071038, 5332.520073193431, 5415.891682166334, 11111.277766945122, 11188.272762270426, 11206.383648899226, 11219.60731374398, 11248.775024499464, 5861.20873682056, 5865.794697185578, 5866.442687944638, 5885.352611212763, 5891.911621325684, 4857.247126695368, 5394.163904594794, 5433.157860531624, 5485.972570137204, 5492.81904390558, 3953.2686453006286, 3957.2679054375035, 3959.7624142550962, 4016.163697049538, 4071.7353372030725, 1180.5159884447507, 1220.1519943639087, 1230.889219970189, 1242.310517662706, 1243.9813402798966, 890.7060669978891, 905.4612505559181, 934.621478301289, 966.9750064931195, 1019.2202964731986, 6373.490120790326, 6677.09859169006, 6679.165104361955, 6763.12079429671, 6764.120664313607, 1012.8581998520066, 1060.9019664647053, 1073.0, 1094.0864378244096, 1101.6694991502518, 4552.544745525487, 4623.884402889955, 4629.976850115728, 4681.531846815359, 4681.625469962395, 12405.379731013414, 12632.873671263169, 12742.745145097046, 12745.490180392866, 12750.681232969064, 11701.882981170249, 12148.392580370946, 12195.695107622381, 12496.937515312366, 12776.808347874789, 9180.31147663928, 9264.675736349196, 9273.211776998896, 9283.350165488486, 9284.118008789153, 6406.9359306408205, 6735.865282694416, 6765.0, 6848.794536163923, 6894.069300644549, 11301.604443844426, 11344.149188810707, 11411.429428528374, 11559.0, 11613.535458581562, 11498.19512634141, 11543.134264930331, 11643.88356116462, 11653.359065251154, 11749.060075194135, 7656.157822639617, 8316.293115085286, 8555.572221388782, 8747.343949203709, 8935.329850261387, 9636.22910167199, 9713.417194968324, 9726.076022777825, 9772.267079969173, 9797.167240784329, 8438.915610843813, 8678.262347700516, 8741.0, 8762.518061506424, 8829.646814127364, 8377.790555236168, 8383.874241886499, 8385.28725058377, 8437.873431898404, 8606.913930860612, 7492.887606685795, 7518.962405187939, 7519.736809211651, 7618.08582970025, 7639.579823109782, 5313.6450205197425, 5363.168708850135, 5450.727463626724, 5519.227308176939, 5681.204631351697, 5633.324001119892, 5649.604527683187, 5675.8864822704145, 5704.515116215168, 5788.0739081746715], "value": 5106.652020893203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.2177522349936, 354.1942081763987, 355.8950109717633, 356.71641045368926, 362.0080978119952, 5829.618821083772, 5890.410958904107, 5910.940890591093, 5926.970365148179, 5940.168376427304, 5774.797882074128, 5780.121460525325, 5795.420457954203, 5820.912686309709, 5859.355470898197, 4284.678649101322, 4484.730916145026, 4513.142502924434, 4516.322551617251, 4524.049949510607, 4461.196984542781, 4533.3426653135275, 4545.681802273843, 4554.223852697451, 4594.150082234781, 4472.485664148616, 4522.9597192645715, 4531.501534831166, 4536.160810250114, 4545.068261006486, 4428.0, 4450.888727781799, 4466.598006179427, 4474.261746811805, 4504.932426013613, 3915.805679267822, 3935.232629637222, 3939.113699417637, 3949.763014219156, 3961.2473630010495, 5617.634853734494, 5664.0937450007805, 5679.716014199274, 5688.800891968803, 5692.146178073281, 5059.2916991621205, 5134.64057515974, 5141.820036298712, 5171.637985341028, 5201.427842937273, 6028.246469191351, 6055.333913269536, 6092.9695351523405, 6107.206063211798, 6114.908276375858, 4217.514985776614, 4318.632916202127, 4321.200577893069, 4367.192069467159, 4410.669199809995, 6168.414000669929, 6267.4045965633195, 6323.6521991290465, 6349.9682501587195, 6373.776917807854, 4411.698548928074, 4415.139047885631, 4417.337399390053, 4420.8673739787855, 4440.600345968878, 4481.7983190756495, 4486.977565112219, 4488.745659396976, 4510.864674059783, 4517.954820451753, 4898.403845961646, 5128.256402821645, 5155.484451554815, 5172.534471897472, 5175.663581867167, 6078.513718902477, 6103.084537319349, 6111.174991376108, 6147.139400483936, 6172.574221307217, 1560.9219539023004, 1560.9921950390176, 1570.6780110077407, 1573.6616627425158, 1587.190532828266, 956.7321150077989, 994.8806143262855, 999.6201443451587, 1002.7766125327089, 1015.9949200253951, 5148.687084793353, 5272.472752724697, 5280.234366016906, 5323.866903327448, 5343.305370301836, 5545.639533430314, 5584.497395234448, 5584.97207513968, 5609.439056094439, 5661.245014045577, 5188.558972487305, 5337.478818536699, 5477.945220547823, 6034.909476357858, 6064.363241859542, 3390.355832391887, 3392.0, 3395.2869897321343, 3396.728261739055, 3410.2838403935452, 6318.831016262006, 6539.50953678476, 6572.474202063919, 6598.95432415943, 6614.669266536654, 6413.839654008687, 6427.967860160763, 6460.709268082947, 6492.577982431127, 6501.1548498694865, 6221.076094235612, 6583.63789991555, 6596.769113081019, 6597.538172327987, 6634.502412319095, 6285.685715714105, 6290.716917738804, 6323.20959880015, 6346.492280617632, 6347.301796802256, 5898.764049438146, 6216.471599914058, 6229.909765790878, 6233.812985610439, 6237.937620623918, 6332.588381755171, 6466.838329041811, 6537.803865884031, 6557.377049180321, 6579.309172536815, 4441.733495990251, 4454.799534020912, 4474.217012022948, 4479.350494178391, 4515.209838278222, 6257.937420625917, 6324.1146239527425, 6351.888419526656, 6380.712867921047, 6384.425401713868, 6099.176611157614, 6151.753929842936, 6163.753449861955, 6168.9691551541955, 6171.876562468636, 5954.404559544011, 6136.877262454636, 6158.692065396802, 6179.969100154471, 6207.734177025443, 6042.063480160582, 6043.395660433922, 6064.181335519648, 6080.90878636812, 6102.511799056154, 6175.536834737502, 6186.783462578788, 6188.164597779242, 6213.409726076015, 6236.906446403398, 5781.94218057814, 6050.610009046314, 6074.271087469532, 6081.8175454734655, 6100.908486372619], "value": 4624.4929703956805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.7712563356627, 799.0730752327302, 841.9031811341696, 891.2914233184617, 895.9507227102507, 15448.0, 15486.535403937873, 15523.0, 15569.844301556981, 16536.503904882844, 15995.920020399912, 16176.595585110379, 16187.676246475094, 16193.919030404832, 16201.189940502987, 735.2977906099688, 865.312076898867, 888.6800751729372, 891.6834523744075, 895.7357579514058, 877.0308808766317, 877.7673916412156, 883.9513826739527, 886.1492966751894, 888.5690440136528, 927.323054170456, 933.1368484152166, 933.8459154239542, 934.9485778282192, 935.5789894547447, 918.1094338491653, 923.5890028937125, 927.9025702301296, 928.0533855467386, 929.5816882402946, 679.3308591037824, 680.2823021712092, 682.2904179653154, 684.1209046375434, 687.1376422589668, 15433.768493472608, 15563.844361556467, 15574.922125389301, 15582.532524024298, 15662.765058524132, 15732.752156917682, 16196.676066478722, 16264.18679066042, 16549.751753723704, 16551.83448165515, 12662.0, 12799.104062715614, 12810.615681529569, 13036.739265214737, 13131.803022954664, 4216.7259128156875, 4684.531546845323, 4711.411073615798, 4778.641601879873, 4983.401991760976, 79350.0, 80371.0, 80427.0, 80521.0, 80972.59513702453, 12127.090468214743, 12228.518641761377, 12257.448414821354, 12280.631581052583, 12409.441575129142, 21496.78503214979, 21522.0, 21540.461488462915, 21670.891645541673, 21674.24140155087, 8480.151984801594, 8701.086385929513, 8870.42342247752, 8872.911270887338, 9003.864942025875, 4852.102361063215, 4865.805367785249, 4922.064807686528, 4950.480199578992, 5162.328897243335, 3771.7171212159196, 3820.2932457495453, 3829.7319187656594, 3841.9807900960877, 3855.479510266134, 635.8601107756378, 649.0264603095357, 650.5543702563759, 660.7753363856312, 683.0983102305009, 677.5223467455432, 695.2317688953734, 778.992210077892, 780.508279783744, 845.471580262336, 11059.612913548148, 11209.775804483865, 11240.718982025352, 11361.431928403546, 11362.772744545064, 792.834533236142, 816.9346452283803, 820.8153165537825, 822.5147163173756, 826.6982551368827, 4853.611711063107, 4909.77905994224, 4948.4309304429735, 5050.823221187241, 5063.797448102108, 71084.0, 76273.23726762773, 76599.0, 76787.23212767912, 83848.0, 64367.35632643614, 87355.0, 94583.0541694588, 100794.49602751939, 100880.49559752154, 88386.55806721054, 89824.5508772452, 90348.0, 90961.0, 92438.0756192443, 9832.55753491109, 9971.152452041657, 10079.949600251952, 10087.193024558164, 10138.746531336776, 55482.72258638681, 55750.0, 55914.44085559255, 56000.719996399755, 57787.0, 78138.21861781536, 79530.6023469879, 80895.0, 81013.0, 81140.59429702813, 12806.167599106027, 12809.487620495449, 12864.421101050288, 13083.738325233251, 13176.275304858325, 14297.499587514387, 14455.13269203851, 14502.274886255434, 14690.0, 15138.318775655342, 13491.662708432368, 13636.977226707839, 13900.51348202808, 14147.787783183467, 14214.005019648524, 13091.803622945854, 13276.070675052653, 13438.664033398853, 14441.855581444051, 14473.059251148641, 13194.604161875159, 13360.665983350495, 13704.52034178799, 13954.162750234613, 14009.299535023412, 10752.784944300915, 10825.188110891871, 11073.335599864035, 11320.320780753182, 11335.093192544411, 11246.550137994389, 11260.718482038015, 11329.0, 11438.656840294805, 11475.655730328104], "value": 7896.74784375021, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 111.0, 111.0, 113.0, 111.0, 110.0, 110.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 149.0, 178.0, 137.0, 152.0, 152.0, 126.0, 201.0, 134.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 160.0, 162.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 170.0, 75.0, 75.0, 75.0, 76.0, 163.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 147.0, 85.0, 86.0, 85.0, 143.0, 85.0, 84.0, 140.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 148.0, 147.0, 148.0, 150.0, 147.0, 155.0, 146.0, 146.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 105.0, 95.0, 99.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 54.0, 55.0, 58.0, 53.0, 55.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 59.0, 58.0, 59.0, 59.0, 60.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 76.0, 77.0, 77.0, 77.0, 78.0, 105.0, 83.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 127.0, 118.0, 120.0, 126.0, 129.0, 132.0, 124.0, 133.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 153.0, 158.0, 155.0, 158.0, 152.0, 154.0, 154.0, 154.0, 153.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 63.0, 61.0, 61.0, 62.0, 63.0, 61.0], "value": 62.3, "unit": "score"}]}]} 02:48:24 INFO - Return code: 0 02:48:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:24 ERROR - # TBPL SUCCESS # 02:48:24 INFO - Running post-action listener: _resource_record_post_action 02:48:24 INFO - ##### 02:48:24 INFO - ##### Finished run-tests step (success) 02:48:24 INFO - ##### 02:48:24 INFO - Running post-run listener: _resource_record_post_run 02:48:24 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 3579904; Write bytes: 253399040; Read time: 256; Write time: 154656 02:48:24 INFO - TinderboxPrint: CPU usage
13.3% 02:48:24 INFO - TinderboxPrint: I/O read bytes / time
3,579,904 / 256 02:48:24 INFO - TinderboxPrint: I/O write bytes / time
253,399,040 / 154,656 02:48:24 INFO - TinderboxPrint: CPU idle
8,220.0 (86.6%) 02:48:24 INFO - TinderboxPrint: CPU user
1,212.4 (12.8%) 02:48:24 INFO - TinderboxPrint: Swap in / out
0 / 0 02:48:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5337088; Read time: 0; Write time: 692 02:48:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 3579904; Write bytes: 248061952; Read time: 256; Write time: 153964 02:48:24 INFO - Running post-run listener: _upload_blobber_files 02:48:24 INFO - Blob upload gear active. 02:48:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:24 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 02:48:24 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'] 02:48:24 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 02:48:25 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:29 INFO - (blobuploader) - INFO - Done attempting. 02:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:30 INFO - (blobuploader) - INFO - Done attempting. 02:48:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:48:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:48:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:31 INFO - (blobuploader) - INFO - Done attempting. 02:48:31 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:31 INFO - Return code: 0 02:48:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c503753cc5b2505b5b1fb8792c5320533da488ba6c17a8f8e5cc341fffbcd89c776d9c9fcd7e87bcbd25552b434ded58b6a3244e62b30a34d0ee38a87f0cb4f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/323af3e3254bb6cd269706439c40fc14b965db85aa134b444a9dbc4c0cd5806f9c3dbc48aa7ee6bcc1a8be8448a8b4ff5188f9b35b03bc91a838e2364561cbbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68c4dc148c1986a3e0147c26765f8219892ab17fed96d62ed8c54b53c6558acb84ae42f145d801be150043f35d34d9d98895115f42b79996001e0842ae9377b"} 02:48:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:31 INFO - Contents: 02:48:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c503753cc5b2505b5b1fb8792c5320533da488ba6c17a8f8e5cc341fffbcd89c776d9c9fcd7e87bcbd25552b434ded58b6a3244e62b30a34d0ee38a87f0cb4f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/323af3e3254bb6cd269706439c40fc14b965db85aa134b444a9dbc4c0cd5806f9c3dbc48aa7ee6bcc1a8be8448a8b4ff5188f9b35b03bc91a838e2364561cbbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68c4dc148c1986a3e0147c26765f8219892ab17fed96d62ed8c54b53c6558acb84ae42f145d801be150043f35d34d9d98895115f42b79996001e0842ae9377b"} 02:48:31 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:31 INFO - Copying logs to upload dir... 02:48:31 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.280637 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-07 02:48:31.304521) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:48:31.309726) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685 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/c503753cc5b2505b5b1fb8792c5320533da488ba6c17a8f8e5cc341fffbcd89c776d9c9fcd7e87bcbd25552b434ded58b6a3244e62b30a34d0ee38a87f0cb4f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/323af3e3254bb6cd269706439c40fc14b965db85aa134b444a9dbc4c0cd5806f9c3dbc48aa7ee6bcc1a8be8448a8b4ff5188f9b35b03bc91a838e2364561cbbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68c4dc148c1986a3e0147c26765f8219892ab17fed96d62ed8c54b53c6558acb84ae42f145d801be150043f35d34d9d98895115f42b79996001e0842ae9377b"} build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011516 build_url: 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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/c503753cc5b2505b5b1fb8792c5320533da488ba6c17a8f8e5cc341fffbcd89c776d9c9fcd7e87bcbd25552b434ded58b6a3244e62b30a34d0ee38a87f0cb4f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/323af3e3254bb6cd269706439c40fc14b965db85aa134b444a9dbc4c0cd5806f9c3dbc48aa7ee6bcc1a8be8448a8b4ff5188f9b35b03bc91a838e2364561cbbe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68c4dc148c1986a3e0147c26765f8219892ab17fed96d62ed8c54b53c6558acb84ae42f145d801be150043f35d34d9d98895115f42b79996001e0842ae9377b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:48:31.339288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:48:31.339650) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465291678.881055-799830685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:48:31.422474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:48:31.422830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:48:31.423117) ========= ========= Total master_lag: 0.36 =========