builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1465291597.0 results: success (0) buildid: 20160606202128 builduid: 7ec3cba5ae654a229f94a8ace0e91e74 revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:36.997048) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:36.997514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:36.997804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.012448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.012781) ========= 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=8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:26:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.4M=0s 2016-06-07 02:26:37 (89.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.155446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.155770) ========= 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=8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014890 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.205252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.205618) ========= 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=8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:26:37,222 truncating revision to first 12 chars 2016-06-07 02:26:37,222 Setting DEBUG logging. 2016-06-07 02:26:37,222 attempt 1/10 2016-06-07 02:26:37,222 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:26:37,522 unpacking tar archive at: mozilla-aurora-e70892847544/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.851263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.851656) ========= script_repo_revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.852313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.852674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.862467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-07 02:26:37.862772) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:26:37 INFO - MultiFileLogger online at 20160607 02:26:37 in /builds/slave/test 02:26:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:26:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:26:37 INFO - {'append_to_log': False, 02:26:37 INFO - 'base_work_dir': '/builds/slave/test', 02:26:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:26:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:26:37 INFO - 'branch': 'Mozilla-Aurora', 02:26:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:26:37 INFO - 'config_files': ('talos/linux_config.py',), 02:26:37 INFO - 'default_actions': ('clobber', 02:26:37 INFO - 'read-buildbot-config', 02:26:37 INFO - 'download-and-extract', 02:26:37 INFO - 'populate-webroot', 02:26:37 INFO - 'create-virtualenv', 02:26:37 INFO - 'install', 02:26:37 INFO - 'run-tests'), 02:26:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:26:37 INFO - 'download_minidump_stackwalk': True, 02:26:37 INFO - 'download_symbols': 'ondemand', 02:26:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:26:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:26:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:26:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:26:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:26:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:26:37 INFO - 'installer_path': 'installer.exe', 02:26:37 INFO - 'log_level': 'info', 02:26:37 INFO - 'log_name': 'talos', 02:26:37 INFO - 'log_to_console': True, 02:26:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:26:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:26:37 INFO - 'opt_config_files': (), 02:26:37 INFO - 'pip_index': False, 02:26:37 INFO - 'sps_profile': False, 02:26:37 INFO - 'sps_profile_interval': 0, 02:26:37 INFO - 'suite': 'dromaeojs', 02:26:37 INFO - 'system_bits': '32', 02:26:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:26:37 INFO - 'title': 'talos-linux64-ix-038', 02:26:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:26:37 INFO - 'use_talos_json': True, 02:26:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:26:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:26:37 INFO - 'work_dir': 'build'} 02:26:37 INFO - ##### 02:26:37 INFO - ##### Running clobber step. 02:26:37 INFO - ##### 02:26:37 INFO - Running pre-action listener: _resource_record_pre_action 02:26:37 INFO - Running main action method: clobber 02:26:37 INFO - rmtree: /builds/slave/test/build 02:26:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:26:38 INFO - Running post-action listener: _resource_record_post_action 02:26:38 INFO - ##### 02:26:38 INFO - ##### Finished clobber step (success) 02:26:38 INFO - ##### 02:26:38 INFO - ##### 02:26:38 INFO - ##### Running read-buildbot-config step. 02:26:38 INFO - ##### 02:26:38 INFO - Running pre-action listener: _resource_record_pre_action 02:26:38 INFO - Running main action method: read_buildbot_config 02:26:38 INFO - Using buildbot properties: 02:26:38 INFO - { 02:26:38 INFO - "project": "", 02:26:38 INFO - "product": "firefox", 02:26:38 INFO - "script_repo_revision": "production", 02:26:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:26:38 INFO - "repository": "", 02:26:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:26:38 INFO - "buildid": "20160606202128", 02:26:38 INFO - "pgo_build": "True", 02:26:38 INFO - "basedir": "/builds/slave/test", 02:26:38 INFO - "buildnumber": 291, 02:26:38 INFO - "slavename": "talos-linux64-ix-038", 02:26:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:26:38 INFO - "platform": "ubuntu64_hw", 02:26:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:26:38 INFO - "branch": "mozilla-aurora", 02:26:38 INFO - "repo_path": "releases/mozilla-aurora", 02:26:38 INFO - "revision": "e70892847544db94d801f80543fe8a7f6d836f90", 02:26:38 INFO - "stage_platform": "linux64-pgo", 02:26:38 INFO - "builduid": "7ec3cba5ae654a229f94a8ace0e91e74", 02:26:38 INFO - "slavebuilddir": "test" 02:26:38 INFO - } 02:26:38 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:26:38 INFO - Running post-action listener: _resource_record_post_action 02:26:38 INFO - ##### 02:26:38 INFO - ##### Finished read-buildbot-config step (success) 02:26:38 INFO - ##### 02:26:38 INFO - ##### 02:26:38 INFO - ##### Running download-and-extract step. 02:26:38 INFO - ##### 02:26:38 INFO - Running pre-action listener: _resource_record_pre_action 02:26:38 INFO - Running main action method: download_and_extract 02:26:38 INFO - mkdir: /builds/slave/test/build/tests 02:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:38 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:26:39 INFO - Downloaded 1361 bytes. 02:26:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:26:39 INFO - Using the following test package requirements: 02:26:39 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:26:39 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:26:39 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:26:39 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'jsshell-linux-x86_64.zip'], 02:26:39 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:26:39 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:26:39 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:26:39 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:26:39 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:26:39 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:39 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:26:39 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:26:39 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:26:39 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:26:39 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:26:39 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:26:39 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:26:39 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:26:40 INFO - Downloaded 24473779 bytes. 02:26:40 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:26:40 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:26:41 INFO - Return code: 0 02:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:43 INFO - Downloaded 24473779 bytes. 02:26:43 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:26:43 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:26:44 INFO - Return code: 0 02:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:44 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:26:44 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:26:44 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:26:44 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:26:44 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:26:45 INFO - Downloaded 10833369 bytes. 02:26:45 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:26:45 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:26:45 INFO - Return code: 0 02:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:45 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:26:45 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:26:45 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:26:45 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:26:45 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:26:47 INFO - Downloaded 63553597 bytes. 02:26:47 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:26:47 INFO - mkdir: /builds/slave/test/properties 02:26:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:47 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:47 INFO - Contents: 02:26:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:26:48 INFO - Running post-action listener: _resource_record_post_action 02:26:48 INFO - Running post-action listener: set_extra_try_arguments 02:26:48 INFO - ##### 02:26:48 INFO - ##### Finished download-and-extract step (success) 02:26:48 INFO - ##### 02:26:48 INFO - ##### 02:26:48 INFO - ##### Running populate-webroot step. 02:26:48 INFO - ##### 02:26:48 INFO - Running pre-action listener: _resource_record_pre_action 02:26:48 INFO - Running main action method: populate_webroot 02:26:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:48 INFO - '--tppagecycles', 02:26:48 INFO - '7'], 02:26:48 INFO - 'tests': ['tsvgm']}}, 02:26:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['damp', 'tps']}, 02:26:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'tests': ['damp', 'tps']}, 02:26:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['dromaeo_dom']}, 02:26:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['a11yr', 02:26:48 INFO - 'ts_paint', 02:26:48 INFO - 'tpaint', 02:26:48 INFO - 'sessionrestore', 02:26:48 INFO - 'sessionrestore_no_auto_restore', 02:26:48 INFO - 'tabpaint']}, 02:26:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:48 INFO - 'ts_paint', 02:26:48 INFO - 'tpaint', 02:26:48 INFO - 'sessionrestore', 02:26:48 INFO - 'sessionrestore_no_auto_restore', 02:26:48 INFO - 'tabpaint']}, 02:26:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:48 INFO - 'ts_paint', 02:26:48 INFO - 'tpaint', 02:26:48 INFO - 'sessionrestore', 02:26:48 INFO - 'sessionrestore_no_auto_restore', 02:26:48 INFO - 'tabpaint']}, 02:26:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:48 INFO - 'ts_paint', 02:26:48 INFO - 'tpaint', 02:26:48 INFO - 'sessionrestore', 02:26:48 INFO - 'sessionrestore_no_auto_restore', 02:26:48 INFO - 'tabpaint']}, 02:26:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['a11yr', 02:26:48 INFO - 'ts_paint', 02:26:48 INFO - 'tpaint', 02:26:48 INFO - 'sessionrestore', 02:26:48 INFO - 'sessionrestore_no_auto_restore', 02:26:48 INFO - 'tabpaint']}, 02:26:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['a11yr', 02:26:48 INFO - 'ts_paint', 02:26:48 INFO - 'tpaint', 02:26:48 INFO - 'sessionrestore', 02:26:48 INFO - 'sessionrestore_no_auto_restore', 02:26:48 INFO - 'tabpaint']}, 02:26:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['tsvgx', 02:26:48 INFO - 'tsvgr_opacity', 02:26:48 INFO - 'tart', 02:26:48 INFO - 'tscrollx', 02:26:48 INFO - 'cart']}, 02:26:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:48 INFO - 'tsvgr_opacity', 02:26:48 INFO - 'tart', 02:26:48 INFO - 'tscrollx', 02:26:48 INFO - 'cart']}, 02:26:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'talos_options': ['--disable-e10s'], 02:26:48 INFO - 'tests': ['tp5o']}, 02:26:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'tests': ['tp5o']}, 02:26:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'talos_options': ['--disable-e10s', 02:26:48 INFO - '--xperf_path', 02:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:48 INFO - 'tests': ['tp5n']}, 02:26:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:48 INFO - 'talos_options': ['--xperf_path', 02:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:48 INFO - 'tests': ['tp5n']}}, 02:26:48 INFO - 'talos.zip': {'path': '', 02:26:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:48 INFO - Running post-action listener: _resource_record_post_action 02:26:48 INFO - ##### 02:26:48 INFO - ##### Finished populate-webroot step (success) 02:26:48 INFO - ##### 02:26:48 INFO - ##### 02:26:48 INFO - ##### Running create-virtualenv step. 02:26:48 INFO - ##### 02:26:48 INFO - Running pre-action listener: _resource_record_pre_action 02:26:48 INFO - Running main action method: create_virtualenv 02:26:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:48 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:26:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:48 INFO - Using real prefix '/usr' 02:26:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:48 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:50 INFO - Installing pip.................done. 02:26:50 INFO - Return code: 0 02:26:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:50 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:26:50 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:26:50 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:26:50 INFO - Using env: {'DISPLAY': ':0', 02:26:50 INFO - 'HOME': '/home/cltbld', 02:26:50 INFO - 'LANG': 'en_US.UTF-8', 02:26:50 INFO - 'LANGUAGE': 'en_US:en', 02:26:50 INFO - 'LOGNAME': 'cltbld', 02:26:50 INFO - 'MAIL': '/var/mail/cltbld', 02:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:50 INFO - 'MOZ_NO_REMOTE': '1', 02:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:50 INFO - 'NO_EM_RESTART': '1', 02:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:50 INFO - 'PWD': '/builds/slave/test', 02:26:50 INFO - 'SHELL': '/bin/bash', 02:26:50 INFO - 'SHLVL': '1', 02:26:50 INFO - 'TERM': 'linux', 02:26:50 INFO - 'TMOUT': '86400', 02:26:50 INFO - 'USER': 'cltbld', 02:26:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:50 INFO - '_': '/tools/buildbot/bin/python'} 02:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:50 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:26:50 INFO - Cleaning up... 02:26:50 INFO - Return code: 0 02:26:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:50 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:26:50 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:26:50 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:26:50 INFO - Using env: {'DISPLAY': ':0', 02:26:50 INFO - 'HOME': '/home/cltbld', 02:26:50 INFO - 'LANG': 'en_US.UTF-8', 02:26:50 INFO - 'LANGUAGE': 'en_US:en', 02:26:50 INFO - 'LOGNAME': 'cltbld', 02:26:50 INFO - 'MAIL': '/var/mail/cltbld', 02:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:50 INFO - 'MOZ_NO_REMOTE': '1', 02:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:50 INFO - 'NO_EM_RESTART': '1', 02:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:50 INFO - 'PWD': '/builds/slave/test', 02:26:50 INFO - 'SHELL': '/bin/bash', 02:26:50 INFO - 'SHLVL': '1', 02:26:50 INFO - 'TERM': 'linux', 02:26:50 INFO - 'TMOUT': '86400', 02:26:50 INFO - 'USER': 'cltbld', 02:26:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:50 INFO - '_': '/tools/buildbot/bin/python'} 02:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:51 INFO - Downloading/unpacking psutil>=3.1.1 02:26:51 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:26:51 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:26:51 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:26:51 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:26:51 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:26:51 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:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:53 INFO - Installing collected packages: psutil 02:26:53 INFO - Running setup.py install for psutil 02:26:53 INFO - building 'psutil._psutil_linux' extension 02:26:53 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:26:53 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:26:53 INFO - building 'psutil._psutil_posix' extension 02:26:53 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:26:53 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:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:53 INFO - Successfully installed psutil 02:26:53 INFO - Cleaning up... 02:26:53 INFO - Return code: 0 02:26:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:53 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:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:53 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:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:53 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:26:53 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:26:53 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:26:53 INFO - Using env: {'DISPLAY': ':0', 02:26:53 INFO - 'HOME': '/home/cltbld', 02:26:53 INFO - 'LANG': 'en_US.UTF-8', 02:26:53 INFO - 'LANGUAGE': 'en_US:en', 02:26:53 INFO - 'LOGNAME': 'cltbld', 02:26:53 INFO - 'MAIL': '/var/mail/cltbld', 02:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:53 INFO - 'MOZ_NO_REMOTE': '1', 02:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:53 INFO - 'NO_EM_RESTART': '1', 02:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:53 INFO - 'PWD': '/builds/slave/test', 02:26:53 INFO - 'SHELL': '/bin/bash', 02:26:53 INFO - 'SHLVL': '1', 02:26:53 INFO - 'TERM': 'linux', 02:26:53 INFO - 'TMOUT': '86400', 02:26:53 INFO - 'USER': 'cltbld', 02:26:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:53 INFO - '_': '/tools/buildbot/bin/python'} 02:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:53 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:26:53 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:26:53 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:26:53 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:26:53 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:26:53 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:26:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:26:55 INFO - Installing collected packages: mozsystemmonitor 02:26:55 INFO - Running setup.py install for mozsystemmonitor 02:26:55 INFO - Successfully installed mozsystemmonitor 02:26:55 INFO - Cleaning up... 02:26:55 INFO - Return code: 0 02:26:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:26:55 INFO - Using env: {'DISPLAY': ':0', 02:26:55 INFO - 'HOME': '/home/cltbld', 02:26:55 INFO - 'LANG': 'en_US.UTF-8', 02:26:55 INFO - 'LANGUAGE': 'en_US:en', 02:26:55 INFO - 'LOGNAME': 'cltbld', 02:26:55 INFO - 'MAIL': '/var/mail/cltbld', 02:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:55 INFO - 'MOZ_NO_REMOTE': '1', 02:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:55 INFO - 'NO_EM_RESTART': '1', 02:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:55 INFO - 'PWD': '/builds/slave/test', 02:26:55 INFO - 'SHELL': '/bin/bash', 02:26:55 INFO - 'SHLVL': '1', 02:26:55 INFO - 'TERM': 'linux', 02:26:55 INFO - 'TMOUT': '86400', 02:26:55 INFO - 'USER': 'cltbld', 02:26:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:55 INFO - '_': '/tools/buildbot/bin/python'} 02:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:56 INFO - Downloading/unpacking jsonschema==2.5.1 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:26:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:26:58 INFO - warning: no files found matching '*.txt' 02:26:58 INFO - no previously-included directories found matching 'build' 02:26:58 INFO - no previously-included directories found matching 'dist' 02:26:58 INFO - no previously-included directories found matching '.git*' 02:26:58 INFO - Installing collected packages: jsonschema, functools32 02:26:58 INFO - Running setup.py install for functools32 02:26:58 INFO - warning: no files found matching '*.txt' 02:26:58 INFO - no previously-included directories found matching 'build' 02:26:58 INFO - no previously-included directories found matching 'dist' 02:26:58 INFO - no previously-included directories found matching '.git*' 02:26:58 INFO - Successfully installed jsonschema functools32 02:26:58 INFO - Cleaning up... 02:26:58 INFO - Return code: 0 02:26:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:26:58 INFO - Using env: {'DISPLAY': ':0', 02:26:58 INFO - 'HOME': '/home/cltbld', 02:26:58 INFO - 'LANG': 'en_US.UTF-8', 02:26:58 INFO - 'LANGUAGE': 'en_US:en', 02:26:58 INFO - 'LOGNAME': 'cltbld', 02:26:58 INFO - 'MAIL': '/var/mail/cltbld', 02:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:58 INFO - 'MOZ_NO_REMOTE': '1', 02:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:58 INFO - 'NO_EM_RESTART': '1', 02:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:58 INFO - 'PWD': '/builds/slave/test', 02:26:58 INFO - 'SHELL': '/bin/bash', 02:26:58 INFO - 'SHLVL': '1', 02:26:58 INFO - 'TERM': 'linux', 02:26:58 INFO - 'TMOUT': '86400', 02:26:58 INFO - 'USER': 'cltbld', 02:26:58 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:58 INFO - '_': '/tools/buildbot/bin/python'} 02:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:00 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:01 INFO - Downloading docopt-0.6.1.tar.gz 02:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:01 INFO - Running setup.py install for blobuploader 02:27:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:01 INFO - Running setup.py install for requests 02:27:01 INFO - Running setup.py install for docopt 02:27:01 INFO - Successfully installed blobuploader requests docopt 02:27:01 INFO - Cleaning up... 02:27:01 INFO - Return code: 0 02:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27: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:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:01 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:27:01 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:27:01 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:27:01 INFO - Using env: {'DISPLAY': ':0', 02:27:01 INFO - 'HOME': '/home/cltbld', 02:27:01 INFO - 'LANG': 'en_US.UTF-8', 02:27:01 INFO - 'LANGUAGE': 'en_US:en', 02:27:01 INFO - 'LOGNAME': 'cltbld', 02:27:01 INFO - 'MAIL': '/var/mail/cltbld', 02:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:01 INFO - 'MOZ_NO_REMOTE': '1', 02:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:01 INFO - 'NO_EM_RESTART': '1', 02:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:01 INFO - 'PWD': '/builds/slave/test', 02:27:01 INFO - 'SHELL': '/bin/bash', 02:27:01 INFO - 'SHLVL': '1', 02:27:01 INFO - 'TERM': 'linux', 02:27:01 INFO - 'TMOUT': '86400', 02:27:01 INFO - 'USER': 'cltbld', 02:27:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:01 INFO - '_': '/tools/buildbot/bin/python'} 02:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:02 INFO - Running setup.py (path:/tmp/pip-_kAR1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:02 INFO - Running setup.py (path:/tmp/pip-XbcxRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:02 INFO - Running setup.py (path:/tmp/pip-vbkNUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:02 INFO - Running setup.py (path:/tmp/pip-wxwH3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:02 INFO - Running setup.py (path:/tmp/pip-N0mSTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:02 INFO - Running setup.py (path:/tmp/pip-DUx0xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:02 INFO - Running setup.py (path:/tmp/pip-5uDK0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:02 INFO - Running setup.py (path:/tmp/pip-84YkGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:02 INFO - Running setup.py (path:/tmp/pip-TYoLQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:02 INFO - Running setup.py (path:/tmp/pip-otAJqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:02 INFO - Running setup.py (path:/tmp/pip-1qdXUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:02 INFO - Running setup.py (path:/tmp/pip-EAaVYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:03 INFO - Running setup.py (path:/tmp/pip-7HcH5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:03 INFO - Running setup.py (path:/tmp/pip-YhrnjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:03 INFO - Running setup.py (path:/tmp/pip-mebvIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:03 INFO - Running setup.py (path:/tmp/pip-ycgaHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:03 INFO - Running setup.py (path:/tmp/pip-S4Iri1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:03 INFO - Running setup.py install for manifestparser 02:27:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:03 INFO - Running setup.py install for mozcrash 02:27:03 INFO - Running setup.py install for mozdebug 02:27:03 INFO - Running setup.py install for mozdevice 02:27:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:27:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:03 INFO - Running setup.py install for mozfile 02:27:03 INFO - Running setup.py install for mozhttpd 02:27:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Running setup.py install for mozinfo 02:27:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Running setup.py install for mozInstall 02:27:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Running setup.py install for mozleak 02:27:04 INFO - Running setup.py install for mozlog 02:27:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Running setup.py install for moznetwork 02:27:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Running setup.py install for mozprocess 02:27:04 INFO - Running setup.py install for mozprofile 02:27:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Running setup.py install for mozrunner 02:27:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:27:04 INFO - Running setup.py install for mozscreenshot 02:27:04 INFO - Running setup.py install for moztest 02:27:05 INFO - Running setup.py install for mozversion 02:27:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:27:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:27:05 INFO - Cleaning up... 02:27:05 INFO - Return code: 0 02:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:05 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:27:05 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:27:05 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:27:05 INFO - Using env: {'DISPLAY': ':0', 02:27:05 INFO - 'HOME': '/home/cltbld', 02:27:05 INFO - 'LANG': 'en_US.UTF-8', 02:27:05 INFO - 'LANGUAGE': 'en_US:en', 02:27:05 INFO - 'LOGNAME': 'cltbld', 02:27:05 INFO - 'MAIL': '/var/mail/cltbld', 02:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:05 INFO - 'MOZ_NO_REMOTE': '1', 02:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:05 INFO - 'NO_EM_RESTART': '1', 02:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:05 INFO - 'PWD': '/builds/slave/test', 02:27:05 INFO - 'SHELL': '/bin/bash', 02:27:05 INFO - 'SHLVL': '1', 02:27:05 INFO - 'TERM': 'linux', 02:27:05 INFO - 'TMOUT': '86400', 02:27:05 INFO - 'USER': 'cltbld', 02:27:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:05 INFO - '_': '/tools/buildbot/bin/python'} 02:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:05 INFO - Running setup.py (path:/tmp/pip-ryBiVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:05 INFO - Running setup.py (path:/tmp/pip-OQ_vx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:05 INFO - Running setup.py (path:/tmp/pip-67o4dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:05 INFO - Running setup.py (path:/tmp/pip-hhj3dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:05 INFO - Running setup.py (path:/tmp/pip-1O9U6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:05 INFO - Running setup.py (path:/tmp/pip-Nh1CpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:05 INFO - Running setup.py (path:/tmp/pip-ryehKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:05 INFO - Running setup.py (path:/tmp/pip-g8QRXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:05 INFO - Running setup.py (path:/tmp/pip-bYdUK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:06 INFO - Running setup.py (path:/tmp/pip-XwNIky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:06 INFO - Running setup.py (path:/tmp/pip-M4ZbCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:06 INFO - Running setup.py (path:/tmp/pip-Ty3iJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:06 INFO - Running setup.py (path:/tmp/pip-N1JR5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:06 INFO - Running setup.py (path:/tmp/pip-Yf5qW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:06 INFO - Running setup.py (path:/tmp/pip-F_YaE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:06 INFO - Running setup.py (path:/tmp/pip-bLDDxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:06 INFO - Running setup.py (path:/tmp/pip-HkvoPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:08 INFO - Downloading blessings-1.6.tar.gz 02:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:27:08 INFO - Installing collected packages: blessings 02:27:08 INFO - Running setup.py install for blessings 02:27:08 INFO - Successfully installed blessings 02:27:08 INFO - Cleaning up... 02:27:08 INFO - Return code: 0 02:27:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:08 INFO - Reading from file tmpfile_stdout 02:27:08 INFO - Current package versions: 02:27:08 INFO - argparse == 1.2.1 02:27:08 INFO - blessings == 1.6 02:27:08 INFO - blobuploader == 1.2.4 02:27:08 INFO - docopt == 0.6.1 02:27:08 INFO - functools32 == 3.2.3-2 02:27:08 INFO - jsonschema == 2.5.1 02:27:08 INFO - manifestparser == 1.1 02:27:08 INFO - mozInstall == 1.12 02:27:08 INFO - mozcrash == 0.17 02:27:08 INFO - mozdebug == 0.1 02:27:08 INFO - mozdevice == 0.48 02:27:08 INFO - mozfile == 1.2 02:27:08 INFO - mozhttpd == 0.7 02:27:08 INFO - mozinfo == 0.9 02:27:08 INFO - mozleak == 0.1 02:27:08 INFO - mozlog == 3.2 02:27:08 INFO - moznetwork == 0.27 02:27:08 INFO - mozprocess == 0.22 02:27:08 INFO - mozprofile == 0.28 02:27:08 INFO - mozrunner == 6.11 02:27:08 INFO - mozscreenshot == 0.1 02:27:08 INFO - mozsystemmonitor == 0.3 02:27:08 INFO - moztest == 0.7 02:27:08 INFO - mozversion == 1.4 02:27:08 INFO - psutil == 3.1.1 02:27:08 INFO - requests == 1.2.3 02:27:08 INFO - wsgiref == 0.1.2 02:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:08 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:27:08 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:27:08 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:27:08 INFO - Using env: {'DISPLAY': ':0', 02:27:08 INFO - 'HOME': '/home/cltbld', 02:27:08 INFO - 'LANG': 'en_US.UTF-8', 02:27:08 INFO - 'LANGUAGE': 'en_US:en', 02:27:08 INFO - 'LOGNAME': 'cltbld', 02:27:08 INFO - 'MAIL': '/var/mail/cltbld', 02:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:08 INFO - 'MOZ_NO_REMOTE': '1', 02:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:08 INFO - 'NO_EM_RESTART': '1', 02:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:08 INFO - 'PWD': '/builds/slave/test', 02:27:08 INFO - 'SHELL': '/bin/bash', 02:27:08 INFO - 'SHLVL': '1', 02:27:08 INFO - 'TERM': 'linux', 02:27:08 INFO - 'TMOUT': '86400', 02:27:08 INFO - 'USER': 'cltbld', 02:27:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:08 INFO - '_': '/tools/buildbot/bin/python'} 02:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 INFO - Cleaning up... 02:27:09 INFO - Return code: 0 02:27:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:09 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:27:09 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:27:09 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:27:09 INFO - Using env: {'DISPLAY': ':0', 02:27:09 INFO - 'HOME': '/home/cltbld', 02:27:09 INFO - 'LANG': 'en_US.UTF-8', 02:27:09 INFO - 'LANGUAGE': 'en_US:en', 02:27:09 INFO - 'LOGNAME': 'cltbld', 02:27:09 INFO - 'MAIL': '/var/mail/cltbld', 02:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:09 INFO - 'MOZ_NO_REMOTE': '1', 02:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:09 INFO - 'NO_EM_RESTART': '1', 02:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:09 INFO - 'PWD': '/builds/slave/test', 02:27:09 INFO - 'SHELL': '/bin/bash', 02:27:09 INFO - 'SHLVL': '1', 02:27:09 INFO - 'TERM': 'linux', 02:27:09 INFO - 'TMOUT': '86400', 02:27:09 INFO - 'USER': 'cltbld', 02:27:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:09 INFO - '_': '/tools/buildbot/bin/python'} 02:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:27:09 INFO - Cleaning up... 02:27:09 INFO - Return code: 0 02:27:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:09 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 0x7effa734cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, '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': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', '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:27:09 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:27:09 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:27:09 INFO - Using env: {'DISPLAY': ':0', 02:27:09 INFO - 'HOME': '/home/cltbld', 02:27:09 INFO - 'LANG': 'en_US.UTF-8', 02:27:09 INFO - 'LANGUAGE': 'en_US:en', 02:27:09 INFO - 'LOGNAME': 'cltbld', 02:27:09 INFO - 'MAIL': '/var/mail/cltbld', 02:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:09 INFO - 'MOZ_NO_REMOTE': '1', 02:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:09 INFO - 'NO_EM_RESTART': '1', 02:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:09 INFO - 'PWD': '/builds/slave/test', 02:27:09 INFO - 'SHELL': '/bin/bash', 02:27:09 INFO - 'SHLVL': '1', 02:27:09 INFO - 'TERM': 'linux', 02:27:09 INFO - 'TMOUT': '86400', 02:27:09 INFO - 'USER': 'cltbld', 02:27:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:09 INFO - '_': '/tools/buildbot/bin/python'} 02:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:09 INFO - Downloading/unpacking flake8 02:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:27:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:27:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:27:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:12 INFO - no previously-included directories found matching 'docs/_build' 02:27:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:27:12 INFO - Running setup.py install for pep8 02:27:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:12 INFO - no previously-included directories found matching 'docs/_build' 02:27:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:27:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:27:12 INFO - Cleaning up... 02:27:12 INFO - Return code: 0 02:27:12 INFO - Running post-action listener: _resource_record_post_action 02:27:12 INFO - Running post-action listener: _start_resource_monitoring 02:27:12 INFO - Starting resource monitoring. 02:27:12 INFO - ##### 02:27:12 INFO - ##### Finished create-virtualenv step (success) 02:27:12 INFO - ##### 02:27:12 INFO - ##### 02:27:12 INFO - ##### Running install step. 02:27:12 INFO - ##### 02:27:12 INFO - Running pre-action listener: _resource_record_pre_action 02:27:12 INFO - Running main action method: install 02:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:12 INFO - Reading from file tmpfile_stdout 02:27:12 INFO - Detecting whether we're running mozinstall >=1.0... 02:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:27:12 INFO - Reading from file tmpfile_stdout 02:27:12 INFO - Output received: 02:27:12 INFO - Usage: mozinstall [options] installer 02:27:12 INFO - Options: 02:27:12 INFO - -h, --help show this help message and exit 02:27:12 INFO - -d DEST, --destination=DEST 02:27:12 INFO - Directory to install application into. [default: 02:27:12 INFO - "/builds/slave/test"] 02:27:12 INFO - --app=APP Application being installed. [default: firefox] 02:27:12 INFO - mkdir: /builds/slave/test/build/application 02:27:12 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:27:12 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:27:28 INFO - Reading from file tmpfile_stdout 02:27:28 INFO - Output received: 02:27:28 INFO - /builds/slave/test/build/application/firefox/firefox 02:27:28 INFO - Running post-action listener: _resource_record_post_action 02:27:28 INFO - ##### 02:27:28 INFO - ##### Finished install step (success) 02:27:28 INFO - ##### 02:27:28 INFO - ##### 02:27:28 INFO - ##### Running run-tests step. 02:27:28 INFO - ##### 02:27:28 INFO - Running pre-action listener: _resource_record_pre_action 02:27:28 INFO - Running main action method: run_tests 02:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:27:28 INFO - Python 2.7.3 02:27:28 INFO - Return code: 0 02:27:28 INFO - grabbing minidump binary from tooltool 02:27:28 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:27:28 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 0x197e1c0>, '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 0x197f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:27:28 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:27:28 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:27:28 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:27:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:27:28 INFO - Return code: 0 02:27:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:27:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:27:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:27:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:27:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:27:29 INFO - Return code: 0 02:27:29 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', '--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-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:27:29 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 --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-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:27:29 INFO - Using env: {'DISPLAY': ':0', 02:27:29 INFO - 'HOME': '/home/cltbld', 02:27:29 INFO - 'LANG': 'en_US.UTF-8', 02:27:29 INFO - 'LANGUAGE': 'en_US:en', 02:27:29 INFO - 'LOGNAME': 'cltbld', 02:27:29 INFO - 'MAIL': '/var/mail/cltbld', 02:27:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:27:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:29 INFO - 'MOZ_NO_REMOTE': '1', 02:27:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:29 INFO - 'NO_EM_RESTART': '1', 02:27:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:29 INFO - 'PWD': '/builds/slave/test', 02:27:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:27:29 INFO - 'SHELL': '/bin/bash', 02:27:29 INFO - 'SHLVL': '1', 02:27:29 INFO - 'TERM': 'linux', 02:27:29 INFO - 'TMOUT': '86400', 02:27:29 INFO - 'USER': 'cltbld', 02:27:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016', 02:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:29 INFO - '_': '/tools/buildbot/bin/python'} 02:27:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--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-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:27:29 INFO - mozversion application_buildid: 20160606202128 02:27:29 INFO - mozversion application_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:27:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:27:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:27:29 INFO - mozversion application_name: Firefox 02:27:29 INFO - mozversion application_remotingname: firefox-dev 02:27:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:29 INFO - mozversion application_vendor: Mozilla 02:27:29 INFO - mozversion application_version: 49.0a2 02:27:29 INFO - mozversion platform_buildid: 20160606202128 02:27:29 INFO - mozversion platform_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:27:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:29 INFO - mozversion platform_version: 49.0a2 02:27:29 INFO - using testdate: 1465291649 02:27:29 INFO - actual date: 1465291649 02:27:29 INFO - starting webserver on 'localhost:57087' 02:27:29 INFO - SUITE-START | Running 2 tests 02:27:29 INFO - TEST-START | dromaeo_css 02:27:29 INFO - operating with platform_type : linux_ 02:27:29 INFO - Initialising browser for dromaeo_css test... 02:27:29 INFO - TEST-INFO | started process 29398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZF4Sjh/profile http://localhost:57087/getInfo.html) 02:27:34 INFO - PROCESS | 29398 | __metrics Screen width/height:1600/1200 02:27:34 INFO - PROCESS | 29398 | colorDepth:24 02:27:34 INFO - PROCESS | 29398 | Browser inner width/height: 1024/697 02:27:34 INFO - PROCESS | 29398 | __metrics 02:27:35 ERROR - PROCESS | 29398 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:27:35 INFO - PROCESS | 29398 | console.error: PushService: 02:27:35 INFO - PROCESS | 29398 | stateChangeProcessEnqueue: Error transitioning state 02:27:35 INFO - PROCESS | 29398 | UnknownError 02:27:36 INFO - TEST-INFO | 29398: exit 0 02:27:36 INFO - Browser initialized. 02:27:36 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:36 INFO - TEST-INFO | started process 29488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZF4Sjh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:48 INFO - PROCESS | 29488 | RSS: Main: 145698816 02:27:48 INFO - PROCESS | 29488 | 02:28:39 INFO - PROCESS | 29488 | 1465291719249 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:30:47 INFO - PROCESS | 29488 | Cycle 1(1): loaded http://localhost:57087/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57087/tests/dromaeo/cssquery-ext.html) 02:30:48 INFO - PROCESS | 29488 | RSS: Main: 256364544 02:30:48 INFO - PROCESS | 29488 | 02:33:50 INFO - PROCESS | 29488 | Cycle 1(1): loaded http://localhost:57087/tests/dromaeo/cssquery-ext.html (next: http://localhost:57087/tests/dromaeo/cssquery-jquery.html) 02:33:51 INFO - PROCESS | 29488 | RSS: Main: 220594176 02:33:51 INFO - PROCESS | 29488 | 02:36:53 INFO - PROCESS | 29488 | Cycle 1(1): loaded http://localhost:57087/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57087/tests/dromaeo/cssquery-mootools.html) 02:36:53 INFO - PROCESS | 29488 | RSS: Main: 231280640 02:36:53 INFO - PROCESS | 29488 | 02:39:55 INFO - PROCESS | 29488 | Cycle 1(1): loaded http://localhost:57087/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57087/tests/dromaeo/cssquery-prototype.html) 02:39:56 INFO - PROCESS | 29488 | RSS: Main: 219942912 02:39:56 INFO - PROCESS | 29488 | 02:42:58 INFO - PROCESS | 29488 | Cycle 1(1): loaded http://localhost:57087/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57087/tests/dromaeo/cssquery-yui.html) 02:42:59 INFO - PROCESS | 29488 | RSS: Main: 194301952 02:42:59 INFO - PROCESS | 29488 | 02:46:01 INFO - PROCESS | 29488 | Cycle 1(1): loaded http://localhost:57087/tests/dromaeo/cssquery-yui.html (next: http://localhost:57087/tests/dromaeo/cssquery-dojo.html) 02:46:02 INFO - PROCESS | 29488 | RSS: Main: 263634944 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | __start_tp_report 02:46:02 INFO - PROCESS | 29488 | _x_x_mozilla_page_load 02:46:02 INFO - PROCESS | 29488 | _x_x_mozilla_page_load_details 02:46:02 INFO - PROCESS | 29488 | |i|pagename|runs| 02:46:02 INFO - PROCESS | 29488 | |0;dojo.html;3391.406503861824;3397.8980630581077;3406.352792969335;3420.777649452784;3450.2581944881863;5675.233843431136;5726.828195154141;5731.11167768996;5775.0182468980265;5775.480206781394;5685.573581981357;5748.683822389767;5755.971220143904;5757.740901659425;5760.913586296209;5069.74651267437;5160.096983027974;5209.791608335662;5243.108671525831;5261.158214685651;5099.745012749367;5203.323567936163;5247.212918062302;5250.4487028861995;5252.448492908247;5133.3326667533165;5165.22521621756;5192.844214673566;5196.29849970253;5243.2659427680155;5307.469253074701;5313.73431328434;5317.707526086064;5319.069162896516;5342.091844386464;5012.624053195988;5106.591472682177;5188.584913206934;5205.427402985669;5215.0873597120735;5536.4186760390385;5551.944480555224;5551.9722401387735;5551.9722401388135;5601.495865372095;6126.437758371631;6135.601185922901;6136.355682653347;6145.324014358417;6147.631142131487;6147.969260153671;6163.798059378378;6215.098810672427;6226.719797609118;6253;5872.970635146839;5912.231409916726;5925.407459254083;5932.2584676915385;5936.7922122725495;6083.482903953213;6454.967725161344;6468.223813142453;6469.708863101172;6474.384933431316;5963.522918166536;5988;6052.061930400795;6085.4861156142915;6093.828787674522;6154.138420621117;6164.6917654118015;6169.105479705418;6170.845728856814;6173.722182501798;5925.496332811759;6035.456808887221;6136.140940268366;6145.784897528565;6148.907766383508;6119.541034422347;6139.386061393825;6177.96911015442;6184.103305020747;6184.628922264678;4661.277501987197;4696.060787842377;4698.318743782201;4707.411573553306;4731.077439899186;4038.5355684096703;4087.305158123126;4111.5477297497255;4180.28935081037;4201.369794530845;5814.3313518945015;5824.301083869963;5841.357450680422;5843.0651095825315;5845.766169353264;6139.723712432862;6182.752689892444;6186.876262474725;6197.566170368031;6202.1937148171355;5742.28221472316;5751.396103409165;5760.107183386498;5814.912776308359;5834.15404766315;5298.072837253465;5301.628885977944;5302.151655735064;5302.3637163540625;5305.045091883498;6388.361163883667;6392.520560957947;6399.13611662429;6409.038644203407;6410.8076757697345;6075.422834830684;6198.442140207403;6225;6245.125682404376;6262.624242545462;6408.839779005376;6447.032945058091;6449.322821103904;6458.095866578777;6459.031145328238;5845.152452894222;5969.373215812451;5969.940300596939;5973.701314934149;5985.790497332572;6134.38656134383;6146.016637338004;6164.137020816999;6247.437730604086;6267.529935254783;6053.606515576474;6055.485283750931;6064.757409703739;6073.180120683651;6096.573239873166;5788.363280039108;5939.613925094855;5995.730192141451;6051.969740151271;6061.848453788514;5879.353271140257;5892.734826932884;5898.321693005188;5899.4985426239255;5948.375420580776;5934.080217566284;5946.5540084494705;6013.398660133952;6017.488513476228;6024.186734790923;5771.163181338767;5837.357890632112;5854.0340843760305;5895.469407753323;5949.702514874326 02:46:02 INFO - PROCESS | 29488 | |1;ext.html;627.1001113402268;661.5369241530926;666.1473314157878;669.2938949408373;678.3549891513081;32199.19502012451;34834.303313933706;34935.65064349356;34961.47557786635;35232.2953540929;35978.82010589943;36512;48639.270410943864;49462;49638.75180624092;8892.8666070009;9033.728988130366;9037.909620903773;9044.909550904473;9050.637974481013;8381.790455238606;8906.643734250621;9028.413153145024;9037.41256818308;9041.864372034392;10984.06635435989;11278.661640150767;11287.266327688674;11289.887101128967;11588.420578971018;10632.149428045737;10754.946225268903;11089.889101108967;11094.55621775136;11103.278286911325;8282.544460054694;8468;10690.144788416908;10892.673219803419;10990.780184396268;44747.10505789899;45387.54612453899;45456.545434545566;45603.77198114021;45649.31526027112;3855.055511399697;3907.8436862525464;3980.223856348013;4033.657139143176;4352.73883566987;34735.82632086849;36002.27995440103;36296.818515907515;36399.27201455956;36580.26839463222;4660.836870709509;4676.392069031038;4808.783604737795;4827.686200396998;4868.245421959567;394626;395401;397665;397740;398552;71975;72625;72660;72701;72846;75625.62187189028;75884.24115758772;76029.61985190038;76311.61844190855;76336;19321.90339048296;19530.902345488183;19542.413727588195;19559.11983960725;19574.510637234183;13682.179069255877;13696.93151534236;13697.315134243447;13700.903927685762;13716.65708357299;19107.416405663058;22048.33854984353;22103.557928841332;22607;23473.178438754563;8015.799605009922;8225.917740822515;8235.83528329442;8245.938515371157;8329.708460203863;1063.2079101069753;1118.765059337532;1162.581470670558;1170.0931777872217;1262.2489618676873;33785.83107084449;34009.48985765215;34300.14249643779;34341.141471463416;34415.483767743506;1064.4624464645306;1121.4112590889847;1170.5259369955181;1184.8874356936078;1257.2079589858513;17902.46292611224;17968.91015544914;17982.190801413966;18025.819741802414;18113.45659630213;653645;657969;658937;660667;660778;64585.35414645887;64870.35129648737;65107.34892651108;65144.34855651478;65147.348526515074;1330.6540299522;1365.9521916733065;1398.182063492868;1427.578864235053;1447.8334991476115;31089.844550777103;34429.31141377108;34550.13624659403;34868;34961;53607.19589206243;53827.730861345444;54288.45711542992;54295;54307.45692543024;446817;448982;450762;451513;452096;37241.37931034418;41319.1736165281;47142.52857471519;47647.76176119097;50233.497665022885;50937.23594146165;51625.741871290404;51664.22503662373;52398.73800631125;52880;42887;43016.139677206906;44278.55721442744;44358;45038.549614503434;43155.568444315155;43356.78321608372;43652;43883.561164389226;44277;43295.56704433041;43868;44082.77958610187;44460.55539444564;44654.55345446634;36670;38647.22705545817;38825;39449.2110157801;39984.600153998086;29189.78247854686;29795.851020744758;29877.701222988362;30006.699933001262;30151.547726783676 02:46:02 INFO - PROCESS | 29488 | |2;jquery.html;431.26254105479626;433.5859254412037;439.3146691161788;443.51213664968526;449.0265284076482;19007.71488427673;20624.793752062476;20674.99999999998;21332.4666883328;21380.89309553454;19239.422817315502;20060.097295621694;20263.39209823704;20364.898175509137;20374.796252037475;5474.206240095174;5729.28383952006;5745.224394706724;5750.827475175752;5752.165935939286;5523.917141242885;5690;5774.942250577483;5779.682117483558;5783.71081445926;5663.461971112738;5697.344805347397;5710.314762228518;5710.543156547466;5733.684647344395;5636.464535869106;5724.7996320128805;5726.971365143189;5737.540996720252;5737.684427356473;5054.721990290533;5157.071727089123;5157.71632560209;5160.56135228506;5169.172932330809;22188.88905555478;22777;23319.300420987398;23604;23933.28200153998;2596.8961241550314;2730.7678847298002;2801;2927.838968856712;3041.969580304191;10446.738831529197;10866;10945.124390048777;11261.831072533836;11290.379029153393;1987.6322880267196;2015.8992050397421;2017.273781438681;2022.9696554551695;2027.6990217762313;86339;88733;90032.54983725105;91233.08766912312;91835;11226.607068752555;11568.132390070778;11640.592579259855;11719.355435451133;11815.704607384712;16379.09914954689;16416.507504774876;16505.917470412573;16509.58726031859;16547;8618.525981071101;8638.222559969507;8699.608517616722;8716.259117974916;8738.95630521856;8705.782355441039;8714.69498567547;8718.65125394977;8829.955850220707;8853.911460885438;4909.599440615366;5035.748212589356;5038.2190760432195;5068.746562671851;5138.948610513922;1937.1089298922373;1966.223341779989;2017.636825371418;2032.4613977296028;2080.62548741228;941.8493041113389;960.9855852162223;1043.634727845248;1049.8792638846478;1059.7865444066654;18702;19256.614867702847;19429.319973800848;19735.802641973685;19766.90116549408;1009.1321463541349;1024.7079582319004;1038.9324693894873;1041.963531276417;1068.5779117248644;10757.56969721218;11087.168462365193;11172.944135279435;11188.776224475465;11263.493142808593;517672;521438;523591;529679;530906;97882;98061.50969245109;99959;100515.49742251389;101150.49424752829;1023.97440063999;1043.118564812732;1063.648995831374;1089.4226060188114;1089.6567581211893;17418.216180271666;17446.563835904202;17702.29190832352;17887.195076221342;18082.819171808114;41343.1731365365;41892.371614425196;41903.371449428894;42578.148437031705;43703.78148109239;59924.70037649958;61305.38694612997;61871;62173.689131554056;62228.377716224066;8787.165219304155;8944.284457243535;8953.418027828171;8986.86519702192;9330.206932410822;8244.505329680238;9994.800103998024;10361.896381036093;12886.162399444007;13813.425183916872;11347;11694.239874408137;11776.528938842694;11830.112741544246;12353.38233088324;10487.580496780349;10659.680209593724;10713.571457141627;10753.408562529135;10877.347359158475;11803.350815704875;11834.349110798645;12021.81967270509;12084.697882553006;12357.196782209128;8777.605007774793;8815.955920220358;8902.59938302791;9071.183593476619;9110.544472776468;11482.540698371971;11581.942090289494;11706.531738730355;11861.940690296493;11984.10119241043 02:46:02 INFO - PROCESS | 29488 | |3;mootools.html;1403.7332906747724;1605.3097168217666;1614.2574415768745;1808.3309175605027;1911.139987005847;9131.223845973092;9587.424754514725;9588.424694518326;9923.702288931325;9932.900670993287;9655.903440965589;9822.656207032755;9823.901760982388;9848.359856609315;9852.901470985287;2060.927867524637;2419.9637005444933;2446.79202267807;2482.7020757509126;2517.6097704855683;2511.3219430753684;2537.3910261537285;2546.5543529882198;2549.987250063747;2551.5407226699185;2481.6401621764835;2501.137107697841;2507.260358194328;2508.8745562721792;2511.824172307939;2063.535704466498;2423.1882319423016;2494.9376265593323;2495.500899820025;2518.2193520008855;2430.040134147002;2454.8158888083467;2460.6678098456837;2466.1491785334033;2466.2231397109854;9784;9802.803943921153;9829.950850245774;9834.114929656294;9840.852387214198;5640.097584386478;5768.250127483442;5770.307563092414;5773.134029895507;5777.393373695785;3570.1967057412135;3587.856485740593;3650.981745091284;3772.86794962175;3781.5840257571645;1146.856642919635;1180.533689192764;1181.6750393641732;1212.5513559982862;1213.5752486629608;14175.43298268068;14251.073680210753;14257.073290236205;14281.285935703174;14311.427542898271;5059.165237735732;5095.668781529189;5274.551663108602;5275.815346462856;5420.593455490854;10736.624218152483;10786.892131078746;10791.6222932197;10794.892051079389;10829.566817327377;4948.505149485095;5843.970780146072;5845.444682755132;5846.181534585162;5846.590738648339;5236.554892834076;5371.677699338053;5386.91919621206;5446.400895901447;5473.17902314656;3873.767573945572;3890.280298144852;3902.1415288636454;3969.603039696065;4009.7594144351433;1207.0765864113785;1235.8702336254744;1248.7003119251315;1252.9624111276676;1257.6981524434252;1000.9399436033862;1012.3015119567475;1015.6546774096843;1022.2435397805571;1028.717102796737;6621.205455345389;6623.933760662332;6649.3018233085795;6737.966310168418;7004.929950700428;474.9406324209474;490.9828156014522;496.681355612942;498.05866911537225;502.2140350351688;4460.687751857339;4476.373307736854;4487.842925497592;4532.093581283756;4581.633469322446;11893.167478276611;12098.939505302416;12581.748365032649;12611.747765044647;12646.683832904251;12240.204386714835;12529.43617537213;12544.372781360895;12610.180338277982;12647;9020.14308640678;9228.95385523068;9231.446113233362;9250.95374523123;9253.074692530694;6689.899651505134;6822.8635427292165;6900.171979362509;6911.412529935012;6951.965240173767;11165.106791456501;11165.832512512481;11337.03635191018;11478.655640330804;11670.591529296435;11667.183297169457;11678.065754739431;11817.940910295394;11899.107566932342;12004.699882503008;7800.414968877243;8062.153473885158;8222.62998165072;8494.490330580185;8674.175953284428;9211.124943130391;9212.263018958602;9239.630414783602;9290;9300.581473833829;8089.595520224083;8271.793205169919;8331.125231850569;8439.620217090369;8448.281896038905;8096.635651395583;8184;8249.628766705633;8303.211194936472;8306.584670766559;7398.704051837866;7669.61651917413;7861.685532578633;7901.644426000728;8065.274125328749;5386.5152136307925;5552.445315311719;5607.243022191952;5698.173764803997;5785.39253378406;5656.208130861765;5663.235463212578;5666.291713535808;5795.82612521625;5814.360420353673 02:46:02 INFO - PROCESS | 29488 | |4;prototype.html;356.90006798096533;361.8769618329769;362.29714354152935;364.83400052975884;365.09638644355243;5607.130894711316;5707.400722924095;5708.800191993281;5718.771249150034;5739.196512488255;5507.284053073105;5525.623981687872;5565.916511252334;5591.41290164533;5611.046122159232;4353;4368.453943257093;4447.35513350564;4447.710898791576;4465.307877279027;4400.339949007643;4402.437134817142;4411.514733379326;4434.334849772527;4451.866444006669;4397.780110994453;4402.163588918112;4406.911861762763;4428.867133985969;4434.534373890743;4312.417823593822;4348.347747837818;4352.434183556149;4370.562943705636;4383.276759334722;3866.709996750255;3888.988862895639;3889.124946886956;3894.5715971243426;3909.4135879618284;5391.353037635469;5396.757145928443;5399.163129714901;5400.594955378323;5412.675239485643;4889.924216672326;5044.243363495469;5057.393112826448;5069.518395752398;5105.2342148678;5830.737616807254;5831.854203644901;5836.2996440427;5842.941570584282;5849.532037436995;4315.287977483711;4328.7402755834755;4334.393184954109;4346.261135606955;4361.781910904474;5726.713664316768;5840.386759390245;5877.647341159544;6051.364606716275;6054.606450580698;4385.627221686193;4390.736555806662;4404.867853964386;4445.555444455593;4448;4304.139172165516;4492.820287188541;4498.527654596286;4507.3689683444345;4511.187986162522;4965.031818795373;4995.100881841304;5004.824831130893;5022.824201152942;5066.417362003343;5853.326867410217;5855.238818953509;5855.765769369263;5868.706564671749;5872.500837428866;1442.7619442792031;1515.3408267403715;1529.747591647388;1529.9770503442458;1545.412743157593;952.6856137474617;953.9761505962267;963.0658261486348;968.4625033106694;974.5030034682221;5055.16589762685;5058.519440653132;5058.747062646853;5066.03745288394;5098.413682426569;5240.502152295602;5288.338957630296;5297;5307.9734601326745;5372.57019438444;4853.6602437829715;5014.420457555858;5046.293518907356;5090.287359769635;5114.28400023997;2843.1896909380725;2844.943101138007;2852.3297025199063;2867.6845546989816;2875.6980517045827;5459.890802184013;5466.234727138204;5504.128596277285;5510.641808282448;5540.944590554042;5262.2632831403635;5410.540104091117;5509.862253443615;5514.097636315465;5552.500274975191;5420.701861397582;5444.863878402993;5503.834884953458;5540.2243685884005;5545.417731138253;5172.948270517247;5313.574914006793;5323.414424413389;5353.608061904011;5378.677279363094;5311.41574426805;5716.914246286392;5765.221695071112;5942.168096466585;5949.167116603592;6192.783252586138;6194.473469755121;6236.906446403398;6249.968750156402;6301.40136687014;4218.177455396169;4218.8312467500955;4335.1979883721615;4335.28467802809;4337.631301339421;5957.791477298274;6009.188759517409;6014.9097763534455;6016.5332213792135;6021.54838387114;5807.332156802022;5871.970640146772;5873.3832947539895;5911.881762364815;5933.732982015906;5616.747246374005;5848.883022339614;5859.414058594107;5875.061229794243;5916.408359164221;5657.264555607745;5674.886502269849;5709.25779648643;5718.656880587178;5781.8554536136935;5663.263775709132;5888.587798854039;5897.764089436375;5902.7343769531335;5917.372722501174;5786.508146807569;5788.681622510802;5827;5848.2689663792025;5878.911816322844 02:46:02 INFO - PROCESS | 29488 | |5;yui.html;839.5718183726301;867.2801574693003;886.8182022685351;892.7857314244583;897.6858099665118;15897.443589474371;17115.229814658338;17134.657306853856;17136.143192840354;17141.228644710987;15932.362705491767;16019.11894845783;16126.193690315467;16139.515814525554;16161.111138887356;749.6888791151665;863.201538576817;888.3470649072942;900.0144841398658;902.571278642646;873.0745409865531;885.6590212768066;888.9822203555925;889.2397000564521;889.8131392407602;943.7310366545536;943.9339246252765;944.2398868910524;944.9196818270456;945.1021529546958;778.2800909159033;910.713125365511;937.5124935033779;939.5677988125402;944.4474982135459;689.9448044156455;694.0803435448001;694.7707256605308;694.8124006518211;695.1310861423221;15877.285522151415;15897.92051039749;15928.442504512286;15937.521874343789;15959.361625534964;15123.621909452242;15411;15491.767623485657;15586;15817.920910395489;13191.07662463628;13253.138545994576;13285.867141328656;13428.597142085655;13675.658108547266;4742.810287588492;4780.306855505932;4794.37673102498;4830.589399901012;4840.370751802243;76236.61881690612;77586.22413775846;77636;77968;78818.21181788223;12600.55898043564;12612.369381530887;12770;12829.61511154667;12890.80663790044;23558.293251202493;23561.7643823563;23562.410939726644;23572.29283121509;23598.88200558986;8822.25010874083;8830.779230519289;8839.224493446374;9082.273418126533;9101.681441149529;4963.255511673206;4988.80044798204;5081.110805609003;5085.74571271435;5281.498257665516;3613.674769270726;3715.405535114423;3729.1422972715886;3733.775973441602;3735.3089678409583;573.4294377094817;605.125593517372;624.8719012602496;679.1137565477001;685.4276678973114;713.8500914807845;763.9121501027453;789.5105034878412;796.1998191817187;844.9746507604782;11182.440877956069;11343.716407089723;11531.250468719674;11552.59565915189;11723.120765942418;679.2155060904663;698.7449580903035;711.9786406407816;736.9815754606178;784.7802615267734;4923.409190897115;5165.431802501722;5352.143657014937;5471.151971444432;5488.1493368527945;78753.60623196847;78969.60515197387;96394;119018.40490797491;121987.39006304911;50231;67808;96781.0321896786;108154;110830;97173.5141324303;97925.79463076647;98375;99095;100550.4972475133;10216.489175541343;10370.637027703995;10434.165266778791;10467.319624224401;10470.685879423629;54298.72850635721;55274.44725552693;55530.44469555414;56063;56385;80412;86051;86562.56718716366;88501;89671.55164224138;14462.566123016326;14666.939496628704;14791.408343666133;14808.851911481179;15282.541523754306;16200.108994004971;16452.83547164513;16537.586560336087;17116.144192790063;17265.741013885054;15106.54680359591;15514.456994005155;15638.452654157505;15763.842361576697;16418.507444776675;15409.614759630651;15714.371425143323;16208.837911620732;16213.918930405272;16297;15531.84468155304;15964;16006.279717412977;16127.67744645124;16286.67426651484;12192.75614487723;12402.441890114786;12467.937660312004;12676.936615316865;12680.556180533637;12502.312372819582;12532.624021279376;12707.046971476992;12762.744745105232;12779.680507987374 02:46:02 INFO - PROCESS | 29488 | __end_tp_report 02:46:02 INFO - PROCESS | 29488 | __start_cc_report 02:46:02 INFO - PROCESS | 29488 | _x_x_mozilla_cycle_collect,965 02:46:02 INFO - PROCESS | 29488 | __end_cc_report 02:46:02 INFO - PROCESS | 29488 | __startTimestamp1465292762201__endTimestamp 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | ------- Summary: start ------- 02:46:02 INFO - PROCESS | 29488 | Number of tests: 6 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | [#0] dojo.html Cycles:165 Average:5711.69 Median:5925.41 stddev:654.80 (11.1%) stddev-sans-first:631.00 02:46:02 INFO - PROCESS | 29488 | Values: 3391.4 3397.9 3406.4 3420.8 3450.3 5675.2 5726.8 5731.1 5775.0 5775.5 5685.6 5748.7 5756.0 5757.7 5760.9 5069.7 5160.1 5209.8 5243.1 5261.2 5099.7 5203.3 5247.2 5250.4 5252.4 5133.3 5165.2 5192.8 5196.3 5243.3 5307.5 5313.7 5317.7 5319.1 5342.1 5012.6 5106.6 5188.6 5205.4 5215.1 5536.4 5551.9 5552.0 5552.0 5601.5 6126.4 6135.6 6136.4 6145.3 6147.6 6148.0 6163.8 6215.1 6226.7 6253.0 5873.0 5912.2 5925.4 5932.3 5936.8 6083.5 6455.0 6468.2 6469.7 6474.4 5963.5 5988.0 6052.1 6085.5 6093.8 6154.1 6164.7 6169.1 6170.8 6173.7 5925.5 6035.5 6136.1 6145.8 6148.9 6119.5 6139.4 6178.0 6184.1 6184.6 4661.3 4696.1 4698.3 4707.4 4731.1 4038.5 4087.3 4111.5 4180.3 4201.4 5814.3 5824.3 5841.4 5843.1 5845.8 6139.7 6182.8 6186.9 6197.6 6202.2 5742.3 5751.4 5760.1 5814.9 5834.2 5298.1 5301.6 5302.2 5302.4 5305.0 6388.4 6392.5 6399.1 6409.0 6410.8 6075.4 6198.4 6225.0 6245.1 6262.6 6408.8 6447.0 6449.3 6458.1 6459.0 5845.2 5969.4 5969.9 5973.7 5985.8 6134.4 6146.0 6164.1 6247.4 6267.5 6053.6 6055.5 6064.8 6073.2 6096.6 5788.4 5939.6 5995.7 6052.0 6061.8 5879.4 5892.7 5898.3 5899.5 5948.4 5934.1 5946.6 6013.4 6017.5 6024.2 5771.2 5837.4 5854.0 5895.5 5949.7 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | [#1] ext.html Cycles:180 Average:67835.51 Median:42103.09 stddev:136775.80 (324.9%) stddev-sans-first:137066.41 02:46:02 INFO - PROCESS | 29488 | Values: 627.1 661.5 666.1 669.3 678.4 32199.2 34834.3 34935.7 34961.5 35232.3 35978.8 36512.0 48639.3 49462.0 49638.8 8892.9 9033.7 9037.9 9044.9 9050.6 8381.8 8906.6 9028.4 9037.4 9041.9 10984.1 11278.7 11287.3 11289.9 11588.4 10632.1 10754.9 11089.9 11094.6 11103.3 8282.5 8468.0 10690.1 10892.7 10990.8 44747.1 45387.5 45456.5 45603.8 45649.3 3855.1 3907.8 3980.2 4033.7 4352.7 34735.8 36002.3 36296.8 36399.3 36580.3 4660.8 4676.4 4808.8 4827.7 4868.2 394626.0 395401.0 397665.0 397740.0 398552.0 71975.0 72625.0 72660.0 72701.0 72846.0 75625.6 75884.2 76029.6 76311.6 76336.0 19321.9 19530.9 19542.4 19559.1 19574.5 13682.2 13696.9 13697.3 13700.9 13716.7 19107.4 22048.3 22103.6 22607.0 23473.2 8015.8 8225.9 8235.8 8245.9 8329.7 1063.2 1118.8 1162.6 1170.1 1262.2 33785.8 34009.5 34300.1 34341.1 34415.5 1064.5 1121.4 1170.5 1184.9 1257.2 17902.5 17968.9 17982.2 18025.8 18113.5 653645.0 657969.0 658937.0 660667.0 660778.0 64585.4 64870.4 65107.3 65144.3 65147.3 1330.7 1366.0 1398.2 1427.6 1447.8 31089.8 34429.3 34550.1 34868.0 34961.0 53607.2 53827.7 54288.5 54295.0 54307.5 446817.0 448982.0 450762.0 451513.0 452096.0 37241.4 41319.2 47142.5 47647.8 50233.5 50937.2 51625.7 51664.2 52398.7 52880.0 42887.0 43016.1 44278.6 44358.0 45038.5 43155.6 43356.8 43652.0 43883.6 44277.0 43295.6 43868.0 44082.8 44460.6 44654.6 36670.0 38647.2 38825.0 39449.2 39984.6 29189.8 29795.9 29877.7 30006.7 30151.5 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | [#2] jquery.html Cycles:180 Average:30686.02 Median:23461.65 stddev:86648.65 (369.3%) stddev-sans-first:86861.95 02:46:02 INFO - PROCESS | 29488 | Values: 431.3 433.6 439.3 443.5 449.0 19007.7 20624.8 20675.0 21332.5 21380.9 19239.4 20060.1 20263.4 20364.9 20374.8 5474.2 5729.3 5745.2 5750.8 5752.2 5523.9 5690.0 5774.9 5779.7 5783.7 5663.5 5697.3 5710.3 5710.5 5733.7 5636.5 5724.8 5727.0 5737.5 5737.7 5054.7 5157.1 5157.7 5160.6 5169.2 22188.9 22777.0 23319.3 23604.0 23933.3 2596.9 2730.8 2801.0 2927.8 3042.0 10446.7 10866.0 10945.1 11261.8 11290.4 1987.6 2015.9 2017.3 2023.0 2027.7 86339.0 88733.0 90032.5 91233.1 91835.0 11226.6 11568.1 11640.6 11719.4 11815.7 16379.1 16416.5 16505.9 16509.6 16547.0 8618.5 8638.2 8699.6 8716.3 8739.0 8705.8 8714.7 8718.7 8830.0 8853.9 4909.6 5035.7 5038.2 5068.7 5138.9 1937.1 1966.2 2017.6 2032.5 2080.6 941.8 961.0 1043.6 1049.9 1059.8 18702.0 19256.6 19429.3 19735.8 19766.9 1009.1 1024.7 1038.9 1042.0 1068.6 10757.6 11087.2 11172.9 11188.8 11263.5 517672.0 521438.0 523591.0 529679.0 530906.0 97882.0 98061.5 99959.0 100515.5 101150.5 1024.0 1043.1 1063.6 1089.4 1089.7 17418.2 17446.6 17702.3 17887.2 18082.8 41343.2 41892.4 41903.4 42578.1 43703.8 59924.7 61305.4 61871.0 62173.7 62228.4 8787.2 8944.3 8953.4 8986.9 9330.2 8244.5 9994.8 10361.9 12886.2 13813.4 11347.0 11694.2 11776.5 11830.1 12353.4 10487.6 10659.7 10713.6 10753.4 10877.3 11803.4 11834.3 12021.8 12084.7 12357.2 8777.6 8816.0 8902.6 9071.2 9110.5 11482.5 11581.9 11706.5 11861.9 11984.1 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | [#3] mootools.html Cycles:180 Average:6397.17 Median:482.96 stddev:3775.81 (781.8%) stddev-sans-first:3767.75 02:46:02 INFO - PROCESS | 29488 | Values: 1403.7 1605.3 1614.3 1808.3 1911.1 9131.2 9587.4 9588.4 9923.7 9932.9 9655.9 9822.7 9823.9 9848.4 9852.9 2060.9 2420.0 2446.8 2482.7 2517.6 2511.3 2537.4 2546.6 2550.0 2551.5 2481.6 2501.1 2507.3 2508.9 2511.8 2063.5 2423.2 2494.9 2495.5 2518.2 2430.0 2454.8 2460.7 2466.1 2466.2 9784.0 9802.8 9830.0 9834.1 9840.9 5640.1 5768.3 5770.3 5773.1 5777.4 3570.2 3587.9 3651.0 3772.9 3781.6 1146.9 1180.5 1181.7 1212.6 1213.6 14175.4 14251.1 14257.1 14281.3 14311.4 5059.2 5095.7 5274.6 5275.8 5420.6 10736.6 10786.9 10791.6 10794.9 10829.6 4948.5 5844.0 5845.4 5846.2 5846.6 5236.6 5371.7 5386.9 5446.4 5473.2 3873.8 3890.3 3902.1 3969.6 4009.8 1207.1 1235.9 1248.7 1253.0 1257.7 1000.9 1012.3 1015.7 1022.2 1028.7 6621.2 6623.9 6649.3 6738.0 7004.9 474.9 491.0 496.7 498.1 502.2 4460.7 4476.4 4487.8 4532.1 4581.6 11893.2 12098.9 12581.7 12611.7 12646.7 12240.2 12529.4 12544.4 12610.2 12647.0 9020.1 9229.0 9231.4 9251.0 9253.1 6689.9 6822.9 6900.2 6911.4 6952.0 11165.1 11165.8 11337.0 11478.7 11670.6 11667.2 11678.1 11817.9 11899.1 12004.7 7800.4 8062.2 8222.6 8494.5 8674.2 9211.1 9212.3 9239.6 9290.0 9300.6 8089.6 8271.8 8331.1 8439.6 8448.3 8096.6 8184.0 8249.6 8303.2 8306.6 7398.7 7669.6 7861.7 7901.6 8065.3 5386.5 5552.4 5607.2 5698.2 5785.4 5656.2 5663.2 5666.3 5795.8 5814.4 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | [#4] prototype.html Cycles:180 Average:4811.32 Median:5375.62 stddev:1380.62 (25.7%) stddev-sans-first:1343.40 02:46:02 INFO - PROCESS | 29488 | Values: 356.9 361.9 362.3 364.8 365.1 5607.1 5707.4 5708.8 5718.8 5739.2 5507.3 5525.6 5565.9 5591.4 5611.0 4353.0 4368.5 4447.4 4447.7 4465.3 4400.3 4402.4 4411.5 4434.3 4451.9 4397.8 4402.2 4406.9 4428.9 4434.5 4312.4 4348.3 4352.4 4370.6 4383.3 3866.7 3889.0 3889.1 3894.6 3909.4 5391.4 5396.8 5399.2 5400.6 5412.7 4889.9 5044.2 5057.4 5069.5 5105.2 5830.7 5831.9 5836.3 5842.9 5849.5 4315.3 4328.7 4334.4 4346.3 4361.8 5726.7 5840.4 5877.6 6051.4 6054.6 4385.6 4390.7 4404.9 4445.6 4448.0 4304.1 4492.8 4498.5 4507.4 4511.2 4965.0 4995.1 5004.8 5022.8 5066.4 5853.3 5855.2 5855.8 5868.7 5872.5 1442.8 1515.3 1529.7 1530.0 1545.4 952.7 954.0 963.1 968.5 974.5 5055.2 5058.5 5058.7 5066.0 5098.4 5240.5 5288.3 5297.0 5308.0 5372.6 4853.7 5014.4 5046.3 5090.3 5114.3 2843.2 2844.9 2852.3 2867.7 2875.7 5459.9 5466.2 5504.1 5510.6 5540.9 5262.3 5410.5 5509.9 5514.1 5552.5 5420.7 5444.9 5503.8 5540.2 5545.4 5172.9 5313.6 5323.4 5353.6 5378.7 5311.4 5716.9 5765.2 5942.2 5949.2 6192.8 6194.5 6236.9 6250.0 6301.4 4218.2 4218.8 4335.2 4335.3 4337.6 5957.8 6009.2 6014.9 6016.5 6021.5 5807.3 5872.0 5873.4 5911.9 5933.7 5616.7 5848.9 5859.4 5875.1 5916.4 5657.3 5674.9 5709.3 5718.7 5781.9 5663.3 5888.6 5897.8 5902.7 5917.4 5786.5 5788.7 5827.0 5848.3 5878.9 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - PROCESS | 29488 | [#5] yui.html Cycles:180 Average:21641.93 Median:4761.56 stddev:29708.24 (623.9%) stddev-sans-first:29750.51 02:46:02 INFO - PROCESS | 29488 | Values: 839.6 867.3 886.8 892.8 897.7 15897.4 17115.2 17134.7 17136.1 17141.2 15932.4 16019.1 16126.2 16139.5 16161.1 749.7 863.2 888.3 900.0 902.6 873.1 885.7 889.0 889.2 889.8 943.7 943.9 944.2 944.9 945.1 778.3 910.7 937.5 939.6 944.4 689.9 694.1 694.8 694.8 695.1 15877.3 15897.9 15928.4 15937.5 15959.4 15123.6 15411.0 15491.8 15586.0 15817.9 13191.1 13253.1 13285.9 13428.6 13675.7 4742.8 4780.3 4794.4 4830.6 4840.4 76236.6 77586.2 77636.0 77968.0 78818.2 12600.6 12612.4 12770.0 12829.6 12890.8 23558.3 23561.8 23562.4 23572.3 23598.9 8822.3 8830.8 8839.2 9082.3 9101.7 4963.3 4988.8 5081.1 5085.7 5281.5 3613.7 3715.4 3729.1 3733.8 3735.3 573.4 605.1 624.9 679.1 685.4 713.9 763.9 789.5 796.2 845.0 11182.4 11343.7 11531.3 11552.6 11723.1 679.2 698.7 712.0 737.0 784.8 4923.4 5165.4 5352.1 5471.2 5488.1 78753.6 78969.6 96394.0 119018.4 121987.4 50231.0 67808.0 96781.0 108154.0 110830.0 97173.5 97925.8 98375.0 99095.0 100550.5 10216.5 10370.6 10434.2 10467.3 10470.7 54298.7 55274.4 55530.4 56063.0 56385.0 80412.0 86051.0 86562.6 88501.0 89671.6 14462.6 14666.9 14791.4 14808.9 15282.5 16200.1 16452.8 16537.6 17116.1 17265.7 15106.5 15514.5 15638.5 15763.8 16418.5 15409.6 15714.4 16208.8 16213.9 16297.0 15531.8 15964.0 16006.3 16127.7 16286.7 12192.8 12402.4 12467.9 12676.9 12680.6 12502.3 12532.6 12707.0 12762.7 12779.7 02:46:02 INFO - PROCESS | 29488 | -------- Summary: end -------- 02:46:02 INFO - PROCESS | 29488 | 02:46:02 INFO - TEST-INFO | 29488: exit 0 02:46:02 INFO - TEST-OK | dromaeo_css | took 1113099ms 02:46:02 INFO - TEST-START | kraken 02:46:02 INFO - operating with platform_type : linux_ 02:46:02 INFO - Initialising browser for kraken test... 02:46:02 INFO - TEST-INFO | started process 29679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvwMjWE/profile http://localhost:57087/getInfo.html) 02:46:07 INFO - PROCESS | 29679 | __metrics Screen width/height:1600/1200 02:46:07 INFO - PROCESS | 29679 | colorDepth:24 02:46:07 INFO - PROCESS | 29679 | Browser inner width/height: 1024/697 02:46:07 INFO - PROCESS | 29679 | __metrics 02:46:08 ERROR - PROCESS | 29679 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:46:08 INFO - PROCESS | 29679 | console.error: PushService: 02:46:08 INFO - PROCESS | 29679 | stateChangeProcessEnqueue: Error transitioning state 02:46:08 INFO - PROCESS | 29679 | UnknownError 02:46:09 INFO - TEST-INFO | 29679: exit 0 02:46:09 INFO - Browser initialized. 02:46:09 INFO - Running cycle 1/1 for kraken test... 02:46:09 INFO - TEST-INFO | started process 29768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvwMjWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:20 INFO - PROCESS | 29768 | RSS: Main: 145506304 02:46:20 INFO - PROCESS | 29768 | 02:46:23 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57087/tests/kraken/driver.html?testName=audio-beat-detection) 02:46:24 INFO - PROCESS | 29768 | RSS: Main: 195100672 02:46:24 INFO - PROCESS | 29768 | 02:46:26 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57087/tests/kraken/driver.html?testName=audio-dft) 02:46:27 INFO - PROCESS | 29768 | RSS: Main: 194453504 02:46:27 INFO - PROCESS | 29768 | 02:46:30 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57087/tests/kraken/driver.html?testName=audio-fft) 02:46:30 INFO - PROCESS | 29768 | RSS: Main: 279965696 02:46:30 INFO - PROCESS | 29768 | 02:46:32 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57087/tests/kraken/driver.html?testName=audio-oscillator) 02:46:33 INFO - PROCESS | 29768 | RSS: Main: 188289024 02:46:33 INFO - PROCESS | 29768 | 02:46:35 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57087/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:36 INFO - PROCESS | 29768 | RSS: Main: 189394944 02:46:36 INFO - PROCESS | 29768 | 02:46:39 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57087/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:39 INFO - PROCESS | 29768 | RSS: Main: 223809536 02:46:39 INFO - PROCESS | 29768 | 02:46:43 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57087/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:43 INFO - PROCESS | 29768 | RSS: Main: 224210944 02:46:43 INFO - PROCESS | 29768 | 02:46:46 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57087/tests/kraken/driver.html?testName=json-parse-financial) 02:46:47 INFO - PROCESS | 29768 | RSS: Main: 223571968 02:46:47 INFO - PROCESS | 29768 | 02:46:48 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57087/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:49 INFO - PROCESS | 29768 | RSS: Main: 199135232 02:46:49 INFO - PROCESS | 29768 | 02:46:50 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:51 INFO - PROCESS | 29768 | RSS: Main: 201596928 02:46:51 INFO - PROCESS | 29768 | 02:46:53 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:54 INFO - PROCESS | 29768 | RSS: Main: 210448384 02:46:54 INFO - PROCESS | 29768 | 02:46:56 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:57 INFO - PROCESS | 29768 | RSS: Main: 216776704 02:46:57 INFO - PROCESS | 29768 | 02:46:59 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:47:00 INFO - PROCESS | 29768 | RSS: Main: 215597056 02:47:00 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | Cycle 1(1): loaded http://localhost:57087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57087/tests/kraken/driver.html?testName=ai-astar) 02:47:02 INFO - PROCESS | 29768 | RSS: Main: 259014656 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | __start_tp_report 02:47:02 INFO - PROCESS | 29768 | _x_x_mozilla_page_load 02:47:02 INFO - PROCESS | 29768 | _x_x_mozilla_page_load_details 02:47:02 INFO - PROCESS | 29768 | |i|pagename|runs| 02:47:02 INFO - PROCESS | 29768 | |0;ai-astar;111;106;110;110;111;109;109;109;110;111 02:47:02 INFO - PROCESS | 29768 | |1;audio-beat-detection;151;125;126;183;127;124;151;122;152;131 02:47:02 INFO - PROCESS | 29768 | |2;audio-dft;160;160;158;160;160;160;161;160;161;160 02:47:02 INFO - PROCESS | 29768 | |3;audio-fft;74;75;75;132;75;81;74;73;97;75 02:47:02 INFO - PROCESS | 29768 | |4;audio-oscillator;85;85;119;84;84;84;118;83;83;135 02:47:02 INFO - PROCESS | 29768 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;116 02:47:02 INFO - PROCESS | 29768 | |6;imaging-darkroom;145;148;145;145;146;145;146;146;146;145 02:47:02 INFO - PROCESS | 29768 | |7;imaging-desaturate;94;94;95;95;95;94;94;95;94;94 02:47:02 INFO - PROCESS | 29768 | |8;json-parse-financial;51;50;50;52;51;52;52;52;51;53 02:47:02 INFO - PROCESS | 29768 | |9;json-stringify-tinderbox;60;60;59;59;60;59;60;60;59;61 02:47:02 INFO - PROCESS | 29768 | |10;stanford-crypto-aes;83;76;77;76;78;82;76;76;132;78 02:47:02 INFO - PROCESS | 29768 | |11;stanford-crypto-ccm;118;123;141;123;123;114;112;115;142;121 02:47:02 INFO - PROCESS | 29768 | |12;stanford-crypto-pbkdf2;157;155;152;154;158;155;154;156;151;156 02:47:02 INFO - PROCESS | 29768 | |13;stanford-crypto-sha256-iterative;63;64;63;64;61;64;61;63;60;59 02:47:02 INFO - PROCESS | 29768 | __end_tp_report 02:47:02 INFO - PROCESS | 29768 | __start_cc_report 02:47:02 INFO - PROCESS | 29768 | _x_x_mozilla_cycle_collect,1563 02:47:02 INFO - PROCESS | 29768 | __end_cc_report 02:47:02 INFO - PROCESS | 29768 | __startTimestamp1465292822484__endTimestamp 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | ------- Summary: start ------- 02:47:02 INFO - PROCESS | 29768 | Number of tests: 14 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.51 (1.4%) stddev-sans-first:1.51 02:47:02 INFO - PROCESS | 29768 | Values: 111.0 106.0 110.0 110.0 111.0 109.0 109.0 109.0 110.0 111.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:141.00 stddev:19.66 (13.9%) stddev-sans-first:20.39 02:47:02 INFO - PROCESS | 29768 | Values: 151.0 125.0 126.0 183.0 127.0 124.0 151.0 122.0 152.0 131.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 02:47:02 INFO - PROCESS | 29768 | Values: 160.0 160.0 158.0 160.0 160.0 160.0 161.0 160.0 161.0 160.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:18.62 (24.8%) stddev-sans-first:19.45 02:47:02 INFO - PROCESS | 29768 | Values: 74.0 75.0 75.0 132.0 75.0 81.0 74.0 73.0 97.0 75.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:84.00 stddev:19.85 (23.6%) stddev-sans-first:20.65 02:47:02 INFO - PROCESS | 29768 | Values: 85.0 85.0 119.0 84.0 84.0 84.0 118.0 83.0 83.0 135.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:47:02 INFO - PROCESS | 29768 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 02:47:02 INFO - PROCESS | 29768 | Values: 145.0 148.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:47:02 INFO - PROCESS | 29768 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 02:47:02 INFO - PROCESS | 29768 | Values: 51.0 50.0 50.0 52.0 51.0 52.0 52.0 52.0 51.0 53.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:47:02 INFO - PROCESS | 29768 | Values: 60.0 60.0 59.0 59.0 60.0 59.0 60.0 60.0 59.0 61.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:77.50 stddev:17.26 (22.3%) stddev-sans-first:18.31 02:47:02 INFO - PROCESS | 29768 | Values: 83.0 76.0 77.0 76.0 78.0 82.0 76.0 76.0 132.0 78.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:123.00 stddev:10.43 (8.5%) stddev-sans-first:10.89 02:47:02 INFO - PROCESS | 29768 | Values: 118.0 123.0 141.0 123.0 123.0 114.0 112.0 115.0 142.0 121.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.50 stddev:2.15 (1.4%) stddev-sans-first:2.13 02:47:02 INFO - PROCESS | 29768 | Values: 157.0 155.0 152.0 154.0 158.0 155.0 154.0 156.0 151.0 156.0 02:47:02 INFO - PROCESS | 29768 | 02:47:02 INFO - PROCESS | 29768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.90 02:47:02 INFO - PROCESS | 29768 | Values: 63.0 64.0 63.0 64.0 61.0 64.0 61.0 63.0 60.0 59.0 02:47:02 INFO - PROCESS | 29768 | -------- Summary: end -------- 02:47:02 INFO - PROCESS | 29768 | 02:47:03 INFO - TEST-INFO | 29768: exit 0 02:47:03 INFO - TEST-OK | kraken | took 60431ms 02:47:03 INFO - SUITE-END | took 1173s 02:47:03 INFO - Completed test suite (00:19:33) 02:47:03 INFO - javascript benchmark 02:47:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3391.406503861824, 3397.8980630581077, 3406.352792969335, 3420.777649452784, 3450.2581944881863, 5675.233843431136, 5726.828195154141, 5731.11167768996, 5775.0182468980265, 5775.480206781394, 5685.573581981357, 5748.683822389767, 5755.971220143904, 5757.740901659425, 5760.913586296209, 5069.74651267437, 5160.096983027974, 5209.791608335662, 5243.108671525831, 5261.158214685651, 5099.745012749367, 5203.323567936163, 5247.212918062302, 5250.4487028861995, 5252.448492908247, 5133.3326667533165, 5165.22521621756, 5192.844214673566, 5196.29849970253, 5243.2659427680155, 5307.469253074701, 5313.73431328434, 5317.707526086064, 5319.069162896516, 5342.091844386464, 5012.624053195988, 5106.591472682177, 5188.584913206934, 5205.427402985669, 5215.0873597120735, 5536.4186760390385, 5551.944480555224, 5551.9722401387735, 5551.9722401388135, 5601.495865372095, 6126.437758371631, 6135.601185922901, 6136.355682653347, 6145.324014358417, 6147.631142131487, 6147.969260153671, 6163.798059378378, 6215.098810672427, 6226.719797609118, 6253.0, 5872.970635146839, 5912.231409916726, 5925.407459254083, 5932.2584676915385, 5936.7922122725495, 6083.482903953213, 6454.967725161344, 6468.223813142453, 6469.708863101172, 6474.384933431316, 5963.522918166536, 5988.0, 6052.061930400795, 6085.4861156142915, 6093.828787674522, 6154.138420621117, 6164.6917654118015, 6169.105479705418, 6170.845728856814, 6173.722182501798, 5925.496332811759, 6035.456808887221, 6136.140940268366, 6145.784897528565, 6148.907766383508, 6119.541034422347, 6139.386061393825, 6177.96911015442, 6184.103305020747, 6184.628922264678, 4661.277501987197, 4696.060787842377, 4698.318743782201, 4707.411573553306, 4731.077439899186, 4038.5355684096703, 4087.305158123126, 4111.5477297497255, 4180.28935081037, 4201.369794530845, 5814.3313518945015, 5824.301083869963, 5841.357450680422, 5843.0651095825315, 5845.766169353264, 6139.723712432862, 6182.752689892444, 6186.876262474725, 6197.566170368031, 6202.1937148171355, 5742.28221472316, 5751.396103409165, 5760.107183386498, 5814.912776308359, 5834.15404766315, 5298.072837253465, 5301.628885977944, 5302.151655735064, 5302.3637163540625, 5305.045091883498, 6388.361163883667, 6392.520560957947, 6399.13611662429, 6409.038644203407, 6410.8076757697345, 6075.422834830684, 6198.442140207403, 6225.0, 6245.125682404376, 6262.624242545462, 6408.839779005376, 6447.032945058091, 6449.322821103904, 6458.095866578777, 6459.031145328238, 5845.152452894222, 5969.373215812451, 5969.940300596939, 5973.701314934149, 5985.790497332572, 6134.38656134383, 6146.016637338004, 6164.137020816999, 6247.437730604086, 6267.529935254783, 6053.606515576474, 6055.485283750931, 6064.757409703739, 6073.180120683651, 6096.573239873166, 5788.363280039108, 5939.613925094855, 5995.730192141451, 6051.969740151271, 6061.848453788514, 5879.353271140257, 5892.734826932884, 5898.321693005188, 5899.4985426239255, 5948.375420580776, 5934.080217566284, 5946.5540084494705, 6013.398660133952, 6017.488513476228, 6024.186734790923, 5771.163181338767, 5837.357890632112, 5854.0340843760305, 5895.469407753323, 5949.702514874326], "value": 5667.724555471867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.1001113402268, 661.5369241530926, 666.1473314157878, 669.2938949408373, 678.3549891513081, 32199.19502012451, 34834.303313933706, 34935.65064349356, 34961.47557786635, 35232.2953540929, 35978.82010589943, 36512.0, 48639.270410943864, 49462.0, 49638.75180624092, 8892.8666070009, 9033.728988130366, 9037.909620903773, 9044.909550904473, 9050.637974481013, 8381.790455238606, 8906.643734250621, 9028.413153145024, 9037.41256818308, 9041.864372034392, 10984.06635435989, 11278.661640150767, 11287.266327688674, 11289.887101128967, 11588.420578971018, 10632.149428045737, 10754.946225268903, 11089.889101108967, 11094.55621775136, 11103.278286911325, 8282.544460054694, 8468.0, 10690.144788416908, 10892.673219803419, 10990.780184396268, 44747.10505789899, 45387.54612453899, 45456.545434545566, 45603.77198114021, 45649.31526027112, 3855.055511399697, 3907.8436862525464, 3980.223856348013, 4033.657139143176, 4352.73883566987, 34735.82632086849, 36002.27995440103, 36296.818515907515, 36399.27201455956, 36580.26839463222, 4660.836870709509, 4676.392069031038, 4808.783604737795, 4827.686200396998, 4868.245421959567, 394626.0, 395401.0, 397665.0, 397740.0, 398552.0, 71975.0, 72625.0, 72660.0, 72701.0, 72846.0, 75625.62187189028, 75884.24115758772, 76029.61985190038, 76311.61844190855, 76336.0, 19321.90339048296, 19530.902345488183, 19542.413727588195, 19559.11983960725, 19574.510637234183, 13682.179069255877, 13696.93151534236, 13697.315134243447, 13700.903927685762, 13716.65708357299, 19107.416405663058, 22048.33854984353, 22103.557928841332, 22607.0, 23473.178438754563, 8015.799605009922, 8225.917740822515, 8235.83528329442, 8245.938515371157, 8329.708460203863, 1063.2079101069753, 1118.765059337532, 1162.581470670558, 1170.0931777872217, 1262.2489618676873, 33785.83107084449, 34009.48985765215, 34300.14249643779, 34341.141471463416, 34415.483767743506, 1064.4624464645306, 1121.4112590889847, 1170.5259369955181, 1184.8874356936078, 1257.2079589858513, 17902.46292611224, 17968.91015544914, 17982.190801413966, 18025.819741802414, 18113.45659630213, 653645.0, 657969.0, 658937.0, 660667.0, 660778.0, 64585.35414645887, 64870.35129648737, 65107.34892651108, 65144.34855651478, 65147.348526515074, 1330.6540299522, 1365.9521916733065, 1398.182063492868, 1427.578864235053, 1447.8334991476115, 31089.844550777103, 34429.31141377108, 34550.13624659403, 34868.0, 34961.0, 53607.19589206243, 53827.730861345444, 54288.45711542992, 54295.0, 54307.45692543024, 446817.0, 448982.0, 450762.0, 451513.0, 452096.0, 37241.37931034418, 41319.1736165281, 47142.52857471519, 47647.76176119097, 50233.497665022885, 50937.23594146165, 51625.741871290404, 51664.22503662373, 52398.73800631125, 52880.0, 42887.0, 43016.139677206906, 44278.55721442744, 44358.0, 45038.549614503434, 43155.568444315155, 43356.78321608372, 43652.0, 43883.561164389226, 44277.0, 43295.56704433041, 43868.0, 44082.77958610187, 44460.55539444564, 44654.55345446634, 36670.0, 38647.22705545817, 38825.0, 39449.2110157801, 39984.600153998086, 29189.78247854686, 29795.851020744758, 29877.701222988362, 30006.699933001262, 30151.547726783676], "value": 22205.160162895452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.26254105479626, 433.5859254412037, 439.3146691161788, 443.51213664968526, 449.0265284076482, 19007.71488427673, 20624.793752062476, 20674.99999999998, 21332.4666883328, 21380.89309553454, 19239.422817315502, 20060.097295621694, 20263.39209823704, 20364.898175509137, 20374.796252037475, 5474.206240095174, 5729.28383952006, 5745.224394706724, 5750.827475175752, 5752.165935939286, 5523.917141242885, 5690.0, 5774.942250577483, 5779.682117483558, 5783.71081445926, 5663.461971112738, 5697.344805347397, 5710.314762228518, 5710.543156547466, 5733.684647344395, 5636.464535869106, 5724.7996320128805, 5726.971365143189, 5737.540996720252, 5737.684427356473, 5054.721990290533, 5157.071727089123, 5157.71632560209, 5160.56135228506, 5169.172932330809, 22188.88905555478, 22777.0, 23319.300420987398, 23604.0, 23933.28200153998, 2596.8961241550314, 2730.7678847298002, 2801.0, 2927.838968856712, 3041.969580304191, 10446.738831529197, 10866.0, 10945.124390048777, 11261.831072533836, 11290.379029153393, 1987.6322880267196, 2015.8992050397421, 2017.273781438681, 2022.9696554551695, 2027.6990217762313, 86339.0, 88733.0, 90032.54983725105, 91233.08766912312, 91835.0, 11226.607068752555, 11568.132390070778, 11640.592579259855, 11719.355435451133, 11815.704607384712, 16379.09914954689, 16416.507504774876, 16505.917470412573, 16509.58726031859, 16547.0, 8618.525981071101, 8638.222559969507, 8699.608517616722, 8716.259117974916, 8738.95630521856, 8705.782355441039, 8714.69498567547, 8718.65125394977, 8829.955850220707, 8853.911460885438, 4909.599440615366, 5035.748212589356, 5038.2190760432195, 5068.746562671851, 5138.948610513922, 1937.1089298922373, 1966.223341779989, 2017.636825371418, 2032.4613977296028, 2080.62548741228, 941.8493041113389, 960.9855852162223, 1043.634727845248, 1049.8792638846478, 1059.7865444066654, 18702.0, 19256.614867702847, 19429.319973800848, 19735.802641973685, 19766.90116549408, 1009.1321463541349, 1024.7079582319004, 1038.9324693894873, 1041.963531276417, 1068.5779117248644, 10757.56969721218, 11087.168462365193, 11172.944135279435, 11188.776224475465, 11263.493142808593, 517672.0, 521438.0, 523591.0, 529679.0, 530906.0, 97882.0, 98061.50969245109, 99959.0, 100515.49742251389, 101150.49424752829, 1023.97440063999, 1043.118564812732, 1063.648995831374, 1089.4226060188114, 1089.6567581211893, 17418.216180271666, 17446.563835904202, 17702.29190832352, 17887.195076221342, 18082.819171808114, 41343.1731365365, 41892.371614425196, 41903.371449428894, 42578.148437031705, 43703.78148109239, 59924.70037649958, 61305.38694612997, 61871.0, 62173.689131554056, 62228.377716224066, 8787.165219304155, 8944.284457243535, 8953.418027828171, 8986.86519702192, 9330.206932410822, 8244.505329680238, 9994.800103998024, 10361.896381036093, 12886.162399444007, 13813.425183916872, 11347.0, 11694.239874408137, 11776.528938842694, 11830.112741544246, 12353.38233088324, 10487.580496780349, 10659.680209593724, 10713.571457141627, 10753.408562529135, 10877.347359158475, 11803.350815704875, 11834.349110798645, 12021.81967270509, 12084.697882553006, 12357.196782209128, 8777.605007774793, 8815.955920220358, 8902.59938302791, 9071.183593476619, 9110.544472776468, 11482.540698371971, 11581.942090289494, 11706.531738730355, 11861.940690296493, 11984.10119241043], "value": 9522.516801230337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.7332906747724, 1605.3097168217666, 1614.2574415768745, 1808.3309175605027, 1911.139987005847, 9131.223845973092, 9587.424754514725, 9588.424694518326, 9923.702288931325, 9932.900670993287, 9655.903440965589, 9822.656207032755, 9823.901760982388, 9848.359856609315, 9852.901470985287, 2060.927867524637, 2419.9637005444933, 2446.79202267807, 2482.7020757509126, 2517.6097704855683, 2511.3219430753684, 2537.3910261537285, 2546.5543529882198, 2549.987250063747, 2551.5407226699185, 2481.6401621764835, 2501.137107697841, 2507.260358194328, 2508.8745562721792, 2511.824172307939, 2063.535704466498, 2423.1882319423016, 2494.9376265593323, 2495.500899820025, 2518.2193520008855, 2430.040134147002, 2454.8158888083467, 2460.6678098456837, 2466.1491785334033, 2466.2231397109854, 9784.0, 9802.803943921153, 9829.950850245774, 9834.114929656294, 9840.852387214198, 5640.097584386478, 5768.250127483442, 5770.307563092414, 5773.134029895507, 5777.393373695785, 3570.1967057412135, 3587.856485740593, 3650.981745091284, 3772.86794962175, 3781.5840257571645, 1146.856642919635, 1180.533689192764, 1181.6750393641732, 1212.5513559982862, 1213.5752486629608, 14175.43298268068, 14251.073680210753, 14257.073290236205, 14281.285935703174, 14311.427542898271, 5059.165237735732, 5095.668781529189, 5274.551663108602, 5275.815346462856, 5420.593455490854, 10736.624218152483, 10786.892131078746, 10791.6222932197, 10794.892051079389, 10829.566817327377, 4948.505149485095, 5843.970780146072, 5845.444682755132, 5846.181534585162, 5846.590738648339, 5236.554892834076, 5371.677699338053, 5386.91919621206, 5446.400895901447, 5473.17902314656, 3873.767573945572, 3890.280298144852, 3902.1415288636454, 3969.603039696065, 4009.7594144351433, 1207.0765864113785, 1235.8702336254744, 1248.7003119251315, 1252.9624111276676, 1257.6981524434252, 1000.9399436033862, 1012.3015119567475, 1015.6546774096843, 1022.2435397805571, 1028.717102796737, 6621.205455345389, 6623.933760662332, 6649.3018233085795, 6737.966310168418, 7004.929950700428, 474.9406324209474, 490.9828156014522, 496.681355612942, 498.05866911537225, 502.2140350351688, 4460.687751857339, 4476.373307736854, 4487.842925497592, 4532.093581283756, 4581.633469322446, 11893.167478276611, 12098.939505302416, 12581.748365032649, 12611.747765044647, 12646.683832904251, 12240.204386714835, 12529.43617537213, 12544.372781360895, 12610.180338277982, 12647.0, 9020.14308640678, 9228.95385523068, 9231.446113233362, 9250.95374523123, 9253.074692530694, 6689.899651505134, 6822.8635427292165, 6900.171979362509, 6911.412529935012, 6951.965240173767, 11165.106791456501, 11165.832512512481, 11337.03635191018, 11478.655640330804, 11670.591529296435, 11667.183297169457, 11678.065754739431, 11817.940910295394, 11899.107566932342, 12004.699882503008, 7800.414968877243, 8062.153473885158, 8222.62998165072, 8494.490330580185, 8674.175953284428, 9211.124943130391, 9212.263018958602, 9239.630414783602, 9290.0, 9300.581473833829, 8089.595520224083, 8271.793205169919, 8331.125231850569, 8439.620217090369, 8448.281896038905, 8096.635651395583, 8184.0, 8249.628766705633, 8303.211194936472, 8306.584670766559, 7398.704051837866, 7669.61651917413, 7861.685532578633, 7901.644426000728, 8065.274125328749, 5386.5152136307925, 5552.445315311719, 5607.243022191952, 5698.173764803997, 5785.39253378406, 5656.208130861765, 5663.235463212578, 5666.291713535808, 5795.82612521625, 5814.360420353673], "value": 4957.98623322865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.90006798096533, 361.8769618329769, 362.29714354152935, 364.83400052975884, 365.09638644355243, 5607.130894711316, 5707.400722924095, 5708.800191993281, 5718.771249150034, 5739.196512488255, 5507.284053073105, 5525.623981687872, 5565.916511252334, 5591.41290164533, 5611.046122159232, 4353.0, 4368.453943257093, 4447.35513350564, 4447.710898791576, 4465.307877279027, 4400.339949007643, 4402.437134817142, 4411.514733379326, 4434.334849772527, 4451.866444006669, 4397.780110994453, 4402.163588918112, 4406.911861762763, 4428.867133985969, 4434.534373890743, 4312.417823593822, 4348.347747837818, 4352.434183556149, 4370.562943705636, 4383.276759334722, 3866.709996750255, 3888.988862895639, 3889.124946886956, 3894.5715971243426, 3909.4135879618284, 5391.353037635469, 5396.757145928443, 5399.163129714901, 5400.594955378323, 5412.675239485643, 4889.924216672326, 5044.243363495469, 5057.393112826448, 5069.518395752398, 5105.2342148678, 5830.737616807254, 5831.854203644901, 5836.2996440427, 5842.941570584282, 5849.532037436995, 4315.287977483711, 4328.7402755834755, 4334.393184954109, 4346.261135606955, 4361.781910904474, 5726.713664316768, 5840.386759390245, 5877.647341159544, 6051.364606716275, 6054.606450580698, 4385.627221686193, 4390.736555806662, 4404.867853964386, 4445.555444455593, 4448.0, 4304.139172165516, 4492.820287188541, 4498.527654596286, 4507.3689683444345, 4511.187986162522, 4965.031818795373, 4995.100881841304, 5004.824831130893, 5022.824201152942, 5066.417362003343, 5853.326867410217, 5855.238818953509, 5855.765769369263, 5868.706564671749, 5872.500837428866, 1442.7619442792031, 1515.3408267403715, 1529.747591647388, 1529.9770503442458, 1545.412743157593, 952.6856137474617, 953.9761505962267, 963.0658261486348, 968.4625033106694, 974.5030034682221, 5055.16589762685, 5058.519440653132, 5058.747062646853, 5066.03745288394, 5098.413682426569, 5240.502152295602, 5288.338957630296, 5297.0, 5307.9734601326745, 5372.57019438444, 4853.6602437829715, 5014.420457555858, 5046.293518907356, 5090.287359769635, 5114.28400023997, 2843.1896909380725, 2844.943101138007, 2852.3297025199063, 2867.6845546989816, 2875.6980517045827, 5459.890802184013, 5466.234727138204, 5504.128596277285, 5510.641808282448, 5540.944590554042, 5262.2632831403635, 5410.540104091117, 5509.862253443615, 5514.097636315465, 5552.500274975191, 5420.701861397582, 5444.863878402993, 5503.834884953458, 5540.2243685884005, 5545.417731138253, 5172.948270517247, 5313.574914006793, 5323.414424413389, 5353.608061904011, 5378.677279363094, 5311.41574426805, 5716.914246286392, 5765.221695071112, 5942.168096466585, 5949.167116603592, 6192.783252586138, 6194.473469755121, 6236.906446403398, 6249.968750156402, 6301.40136687014, 4218.177455396169, 4218.8312467500955, 4335.1979883721615, 4335.28467802809, 4337.631301339421, 5957.791477298274, 6009.188759517409, 6014.9097763534455, 6016.5332213792135, 6021.54838387114, 5807.332156802022, 5871.970640146772, 5873.3832947539895, 5911.881762364815, 5933.732982015906, 5616.747246374005, 5848.883022339614, 5859.414058594107, 5875.061229794243, 5916.408359164221, 5657.264555607745, 5674.886502269849, 5709.25779648643, 5718.656880587178, 5781.8554536136935, 5663.263775709132, 5888.587798854039, 5897.764089436375, 5902.7343769531335, 5917.372722501174, 5786.508146807569, 5788.681622510802, 5827.0, 5848.2689663792025, 5878.911816322844], "value": 4374.993675604156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.5718183726301, 867.2801574693003, 886.8182022685351, 892.7857314244583, 897.6858099665118, 15897.443589474371, 17115.229814658338, 17134.657306853856, 17136.143192840354, 17141.228644710987, 15932.362705491767, 16019.11894845783, 16126.193690315467, 16139.515814525554, 16161.111138887356, 749.6888791151665, 863.201538576817, 888.3470649072942, 900.0144841398658, 902.571278642646, 873.0745409865531, 885.6590212768066, 888.9822203555925, 889.2397000564521, 889.8131392407602, 943.7310366545536, 943.9339246252765, 944.2398868910524, 944.9196818270456, 945.1021529546958, 778.2800909159033, 910.713125365511, 937.5124935033779, 939.5677988125402, 944.4474982135459, 689.9448044156455, 694.0803435448001, 694.7707256605308, 694.8124006518211, 695.1310861423221, 15877.285522151415, 15897.92051039749, 15928.442504512286, 15937.521874343789, 15959.361625534964, 15123.621909452242, 15411.0, 15491.767623485657, 15586.0, 15817.920910395489, 13191.07662463628, 13253.138545994576, 13285.867141328656, 13428.597142085655, 13675.658108547266, 4742.810287588492, 4780.306855505932, 4794.37673102498, 4830.589399901012, 4840.370751802243, 76236.61881690612, 77586.22413775846, 77636.0, 77968.0, 78818.21181788223, 12600.55898043564, 12612.369381530887, 12770.0, 12829.61511154667, 12890.80663790044, 23558.293251202493, 23561.7643823563, 23562.410939726644, 23572.29283121509, 23598.88200558986, 8822.25010874083, 8830.779230519289, 8839.224493446374, 9082.273418126533, 9101.681441149529, 4963.255511673206, 4988.80044798204, 5081.110805609003, 5085.74571271435, 5281.498257665516, 3613.674769270726, 3715.405535114423, 3729.1422972715886, 3733.775973441602, 3735.3089678409583, 573.4294377094817, 605.125593517372, 624.8719012602496, 679.1137565477001, 685.4276678973114, 713.8500914807845, 763.9121501027453, 789.5105034878412, 796.1998191817187, 844.9746507604782, 11182.440877956069, 11343.716407089723, 11531.250468719674, 11552.59565915189, 11723.120765942418, 679.2155060904663, 698.7449580903035, 711.9786406407816, 736.9815754606178, 784.7802615267734, 4923.409190897115, 5165.431802501722, 5352.143657014937, 5471.151971444432, 5488.1493368527945, 78753.60623196847, 78969.60515197387, 96394.0, 119018.40490797491, 121987.39006304911, 50231.0, 67808.0, 96781.0321896786, 108154.0, 110830.0, 97173.5141324303, 97925.79463076647, 98375.0, 99095.0, 100550.4972475133, 10216.489175541343, 10370.637027703995, 10434.165266778791, 10467.319624224401, 10470.685879423629, 54298.72850635721, 55274.44725552693, 55530.44469555414, 56063.0, 56385.0, 80412.0, 86051.0, 86562.56718716366, 88501.0, 89671.55164224138, 14462.566123016326, 14666.939496628704, 14791.408343666133, 14808.851911481179, 15282.541523754306, 16200.108994004971, 16452.83547164513, 16537.586560336087, 17116.144192790063, 17265.741013885054, 15106.54680359591, 15514.456994005155, 15638.452654157505, 15763.842361576697, 16418.507444776675, 15409.614759630651, 15714.371425143323, 16208.837911620732, 16213.918930405272, 16297.0, 15531.84468155304, 15964.0, 16006.279717412977, 16127.67744645124, 16286.67426651484, 12192.75614487723, 12402.441890114786, 12467.937660312004, 12676.936615316865, 12680.556180533637, 12502.312372819582, 12532.624021279376, 12707.046971476992, 12762.744745105232, 12779.680507987374], "value": 8244.39043661693, "unit": "score"}], "name": "dromaeo_css", "value": 7736.004179383714, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 110.0, 111.0, 109.0, 109.0, 109.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 126.0, 183.0, 127.0, 124.0, 151.0, 122.0, 152.0, 131.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 158.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 132.0, 75.0, 81.0, 74.0, 73.0, 97.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 84.0, 84.0, 84.0, 118.0, 83.0, 83.0, 135.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 52.0, 51.0, 52.0, 52.0, 52.0, 51.0, 53.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 61.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 77.0, 76.0, 78.0, 82.0, 76.0, 76.0, 132.0, 78.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 123.0, 141.0, 123.0, 123.0, 114.0, 112.0, 115.0, 142.0, 121.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 152.0, 154.0, 158.0, 155.0, 154.0, 156.0, 151.0, 156.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 61.0, 64.0, 61.0, 63.0, 60.0, 59.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1479.4, "alertThreshold": 2.0}]} 02:47:03 INFO - Return code: 0 02:47:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:47:03 ERROR - # TBPL SUCCESS # 02:47:03 INFO - Running post-action listener: _resource_record_post_action 02:47:03 INFO - ##### 02:47:03 INFO - ##### Finished run-tests step (success) 02:47:03 INFO - ##### 02:47:03 INFO - Running post-run listener: _resource_record_post_run 02:47:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 270336; Write bytes: 505630720; Read time: 132; Write time: 721744 02:47:03 INFO - TinderboxPrint: CPU usage
13.2% 02:47:03 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 132 02:47:03 INFO - TinderboxPrint: I/O write bytes / time
505,630,720 / 721,744 02:47:03 INFO - TinderboxPrint: CPU idle
8,252.6 (86.8%) 02:47:03 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 02:47:03 INFO - TinderboxPrint: Swap in / out
0 / 0 02:47:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 258932736; Read time: 0; Write time: 399696 02:47:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 270336; Write bytes: 246697984; Read time: 132; Write time: 322048 02:47:04 INFO - Running post-run listener: _upload_blobber_files 02:47:04 INFO - Blob upload gear active. 02:47:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:47:04 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:47:04 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:47:04 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:47:04 INFO - (blobuploader) - INFO - Open directory for files ... 02:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:47:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:05 INFO - (blobuploader) - INFO - Done attempting. 02:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:10 INFO - (blobuploader) - INFO - Done attempting. 02:47:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:47:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:47:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:11 INFO - (blobuploader) - INFO - Done attempting. 02:47:11 INFO - (blobuploader) - INFO - Iteration through files over. 02:47:11 INFO - Return code: 0 02:47:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:47:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:47:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239348900d3cd785fc5310136f40f793f958c79551c3713ec425611bb9db25d4132ab768b7f0bb5accf4ea1a63d86a4dbbbb18836fb5aea7a4957917fa2a6974", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaf6cb2b80b050666d67146ecd453a9b41e374659e0b1fbae6fed143e90292f5216ce5fd0005ef438f35c136d16cf310ea6847e65e428db2b2e9f0b5e87289", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a6716e1bb1ecfcfe67cfe82b3a44aa66524ca6f80232d01a75bdab397e32b257968bde1c7acfead8785ae10059b44ee53dd00ace253978055cea1abfdf809b"} 02:47:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:47:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:47:11 INFO - Contents: 02:47:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239348900d3cd785fc5310136f40f793f958c79551c3713ec425611bb9db25d4132ab768b7f0bb5accf4ea1a63d86a4dbbbb18836fb5aea7a4957917fa2a6974", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaf6cb2b80b050666d67146ecd453a9b41e374659e0b1fbae6fed143e90292f5216ce5fd0005ef438f35c136d16cf310ea6847e65e428db2b2e9f0b5e87289", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a6716e1bb1ecfcfe67cfe82b3a44aa66524ca6f80232d01a75bdab397e32b257968bde1c7acfead8785ae10059b44ee53dd00ace253978055cea1abfdf809b"} 02:47:11 INFO - Running post-run listener: copy_logs_to_upload_dir 02:47:11 INFO - Copying logs to upload dir... 02:47:11 INFO - mkdir: /builds/slave/test/build/upload/logs 02:47:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.262924 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-07 02:47:11.144994) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:11.148953) ========= 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=8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239348900d3cd785fc5310136f40f793f958c79551c3713ec425611bb9db25d4132ab768b7f0bb5accf4ea1a63d86a4dbbbb18836fb5aea7a4957917fa2a6974", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaf6cb2b80b050666d67146ecd453a9b41e374659e0b1fbae6fed143e90292f5216ce5fd0005ef438f35c136d16cf310ea6847e65e428db2b2e9f0b5e87289", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a6716e1bb1ecfcfe67cfe82b3a44aa66524ca6f80232d01a75bdab397e32b257968bde1c7acfead8785ae10059b44ee53dd00ace253978055cea1abfdf809b"} 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.011353 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239348900d3cd785fc5310136f40f793f958c79551c3713ec425611bb9db25d4132ab768b7f0bb5accf4ea1a63d86a4dbbbb18836fb5aea7a4957917fa2a6974", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaf6cb2b80b050666d67146ecd453a9b41e374659e0b1fbae6fed143e90292f5216ce5fd0005ef438f35c136d16cf310ea6847e65e428db2b2e9f0b5e87289", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14a6716e1bb1ecfcfe67cfe82b3a44aa66524ca6f80232d01a75bdab397e32b257968bde1c7acfead8785ae10059b44ee53dd00ace253978055cea1abfdf809b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:11.173993) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:11.174337) ========= 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=8783db0840cc980e80bb0bd400000236-1465291596.243952-1383014016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:11.260912) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:47:11.261224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:47:11.261531) ========= ========= Total master_lag: 0.18 =========