builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1465320280.13 results: success (0) buildid: 20160607090033 builduid: cab56e29e0a34b5e857f07f942298139 revision: ee6ea28c089918834cb26b67c77653114af3dce5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.130603) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.131039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.131337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.145771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.146050) ========= 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=cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 10:24:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-07 10:24:41 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.279079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.279426) ========= 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=cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019883 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:40.329157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 10:24:40.329583) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev ee6ea28c089918834cb26b67c77653114af3dce5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev ee6ea28c089918834cb26b67c77653114af3dce5 --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=cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 10:24:41,261 truncating revision to first 12 chars 2016-06-07 10:24:41,261 Setting DEBUG logging. 2016-06-07 10:24:41,261 attempt 1/10 2016-06-07 10:24:41,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/ee6ea28c0899?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 10:24:42,135 unpacking tar archive at: larch-ee6ea28c0899/testing/mozharness/ program finished with exit code 0 elapsedTime=1.212265 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 10:24:41.555076) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:41.555433) ========= script_repo_revision: ee6ea28c089918834cb26b67c77653114af3dce5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:41.555816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:41.556089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 10:24:41.566397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 10:24:41.566668) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:24:42 INFO - MultiFileLogger online at 20160607 10:24:42 in /builds/slave/test 10:24:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 10:24:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:24:42 INFO - {'append_to_log': False, 10:24:42 INFO - 'base_work_dir': '/builds/slave/test', 10:24:42 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 10:24:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:24:42 INFO - 'branch': 'Larch-Non-PGO', 10:24:42 INFO - 'buildbot_json_path': 'buildprops.json', 10:24:42 INFO - 'config_files': ('talos/linux_config.py',), 10:24:42 INFO - 'default_actions': ('clobber', 10:24:42 INFO - 'read-buildbot-config', 10:24:42 INFO - 'download-and-extract', 10:24:42 INFO - 'populate-webroot', 10:24:42 INFO - 'create-virtualenv', 10:24:42 INFO - 'install', 10:24:42 INFO - 'run-tests'), 10:24:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:24:42 INFO - 'download_minidump_stackwalk': True, 10:24:42 INFO - 'download_symbols': 'ondemand', 10:24:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:24:42 INFO - 'tooltool.py': '/tools/tooltool.py', 10:24:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:24:42 INFO - '/tools/misc-python/virtualenv.py')}, 10:24:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:24:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:24:42 INFO - 'installer_path': 'installer.exe', 10:24:42 INFO - 'log_level': 'info', 10:24:42 INFO - 'log_name': 'talos', 10:24:42 INFO - 'log_to_console': True, 10:24:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:24:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:24:42 INFO - 'opt_config_files': (), 10:24:42 INFO - 'pip_index': False, 10:24:42 INFO - 'sps_profile': False, 10:24:42 INFO - 'sps_profile_interval': 0, 10:24:42 INFO - 'suite': 'dromaeojs', 10:24:42 INFO - 'system_bits': '32', 10:24:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:24:42 INFO - 'title': 'talos-linux64-ix-054', 10:24:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:24:42 INFO - 'use_talos_json': True, 10:24:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:24:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:24:42 INFO - 'work_dir': 'build'} 10:24:42 INFO - ##### 10:24:42 INFO - ##### Running clobber step. 10:24:42 INFO - ##### 10:24:42 INFO - Running pre-action listener: _resource_record_pre_action 10:24:42 INFO - Running main action method: clobber 10:24:42 INFO - rmtree: /builds/slave/test/build 10:24:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:24:43 INFO - Running post-action listener: _resource_record_post_action 10:24:43 INFO - ##### 10:24:43 INFO - ##### Finished clobber step (success) 10:24:43 INFO - ##### 10:24:43 INFO - ##### 10:24:43 INFO - ##### Running read-buildbot-config step. 10:24:43 INFO - ##### 10:24:43 INFO - Running pre-action listener: _resource_record_pre_action 10:24:43 INFO - Running main action method: read_buildbot_config 10:24:43 INFO - Using buildbot properties: 10:24:43 INFO - { 10:24:43 INFO - "project": "", 10:24:43 INFO - "product": "firefox", 10:24:43 INFO - "script_repo_revision": "production", 10:24:43 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 10:24:43 INFO - "repository": "", 10:24:43 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 10:24:43 INFO - "buildid": "20160607090033", 10:24:43 INFO - "pgo_build": "False", 10:24:43 INFO - "basedir": "/builds/slave/test", 10:24:43 INFO - "buildnumber": 7, 10:24:43 INFO - "slavename": "talos-linux64-ix-054", 10:24:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:24:43 INFO - "platform": "ubuntu64_hw", 10:24:43 INFO - "scheduler": "tests-larch-linux64-talos", 10:24:43 INFO - "branch": "larch", 10:24:43 INFO - "repo_path": "projects/larch", 10:24:43 INFO - "revision": "ee6ea28c089918834cb26b67c77653114af3dce5", 10:24:43 INFO - "stage_platform": "linux64", 10:24:43 INFO - "builduid": "cab56e29e0a34b5e857f07f942298139", 10:24:43 INFO - "slavebuilddir": "test" 10:24:43 INFO - } 10:24:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:24:43 INFO - Running post-action listener: _resource_record_post_action 10:24:43 INFO - ##### 10:24:43 INFO - ##### Finished read-buildbot-config step (success) 10:24:43 INFO - ##### 10:24:43 INFO - ##### 10:24:43 INFO - ##### Running download-and-extract step. 10:24:43 INFO - ##### 10:24:43 INFO - Running pre-action listener: _resource_record_pre_action 10:24:43 INFO - Running main action method: download_and_extract 10:24:43 INFO - mkdir: /builds/slave/test/build/tests 10:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:43 INFO - https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:24:43 INFO - Downloaded 1361 bytes. 10:24:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:24:43 INFO - Using the following test package requirements: 10:24:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:24:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:24:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:24:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'jsshell-linux-x86_64.zip'], 10:24:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:24:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:24:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:24:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:24:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:24:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:24:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:24:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:43 INFO - https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:24:44 INFO - Downloaded 22878252 bytes. 10:24:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:24:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:24:46 INFO - Return code: 0 10:24:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:46 INFO - https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:24:47 INFO - Downloaded 22878252 bytes. 10:24:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:24:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:24:48 INFO - Return code: 0 10:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:48 INFO - https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:24:49 INFO - Downloaded 10833369 bytes. 10:24:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:24:49 INFO - Return code: 0 10:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:49 INFO - https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:24:51 INFO - Downloaded 55221906 bytes. 10:24:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:24:51 INFO - mkdir: /builds/slave/test/properties 10:24:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:24:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:24:51 INFO - Contents: 10:24:51 INFO - build_url:https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:24:52 INFO - Running post-action listener: _resource_record_post_action 10:24:52 INFO - Running post-action listener: set_extra_try_arguments 10:24:52 INFO - ##### 10:24:52 INFO - ##### Finished download-and-extract step (success) 10:24:52 INFO - ##### 10:24:52 INFO - ##### 10:24:52 INFO - ##### Running populate-webroot step. 10:24:52 INFO - ##### 10:24:52 INFO - Running pre-action listener: _resource_record_pre_action 10:24:52 INFO - Running main action method: populate_webroot 10:24:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:24:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:24:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:24:52 INFO - '--tppagecycles', 10:24:52 INFO - '7'], 10:24:52 INFO - 'tests': ['tsvgm']}}, 10:24:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:24:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:24:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:24:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:24:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:24:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['damp', 'tps']}, 10:24:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'tests': ['damp', 'tps']}, 10:24:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['dromaeo_dom']}, 10:24:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:24:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['a11yr', 10:24:52 INFO - 'ts_paint', 10:24:52 INFO - 'tpaint', 10:24:52 INFO - 'sessionrestore', 10:24:52 INFO - 'sessionrestore_no_auto_restore', 10:24:52 INFO - 'tabpaint']}, 10:24:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:24:52 INFO - 'ts_paint', 10:24:52 INFO - 'tpaint', 10:24:52 INFO - 'sessionrestore', 10:24:52 INFO - 'sessionrestore_no_auto_restore', 10:24:52 INFO - 'tabpaint']}, 10:24:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:24:52 INFO - 'ts_paint', 10:24:52 INFO - 'tpaint', 10:24:52 INFO - 'sessionrestore', 10:24:52 INFO - 'sessionrestore_no_auto_restore', 10:24:52 INFO - 'tabpaint']}, 10:24:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:24:52 INFO - 'ts_paint', 10:24:52 INFO - 'tpaint', 10:24:52 INFO - 'sessionrestore', 10:24:52 INFO - 'sessionrestore_no_auto_restore', 10:24:52 INFO - 'tabpaint']}, 10:24:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['a11yr', 10:24:52 INFO - 'ts_paint', 10:24:52 INFO - 'tpaint', 10:24:52 INFO - 'sessionrestore', 10:24:52 INFO - 'sessionrestore_no_auto_restore', 10:24:52 INFO - 'tabpaint']}, 10:24:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['a11yr', 10:24:52 INFO - 'ts_paint', 10:24:52 INFO - 'tpaint', 10:24:52 INFO - 'sessionrestore', 10:24:52 INFO - 'sessionrestore_no_auto_restore', 10:24:52 INFO - 'tabpaint']}, 10:24:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['tsvgx', 10:24:52 INFO - 'tsvgr_opacity', 10:24:52 INFO - 'tart', 10:24:52 INFO - 'tscrollx', 10:24:52 INFO - 'cart']}, 10:24:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:24:52 INFO - 'tsvgr_opacity', 10:24:52 INFO - 'tart', 10:24:52 INFO - 'tscrollx', 10:24:52 INFO - 'cart']}, 10:24:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'talos_options': ['--disable-e10s'], 10:24:52 INFO - 'tests': ['tp5o']}, 10:24:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'tests': ['tp5o']}, 10:24:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'talos_options': ['--disable-e10s', 10:24:52 INFO - '--xperf_path', 10:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:52 INFO - 'tests': ['tp5n']}, 10:24:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:24:52 INFO - 'talos_options': ['--xperf_path', 10:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:24:52 INFO - 'tests': ['tp5n']}}, 10:24:52 INFO - 'talos.zip': {'path': '', 10:24:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:24:52 INFO - Running post-action listener: _resource_record_post_action 10:24:52 INFO - ##### 10:24:52 INFO - ##### Finished populate-webroot step (success) 10:24:52 INFO - ##### 10:24:52 INFO - ##### 10:24:52 INFO - ##### Running create-virtualenv step. 10:24:52 INFO - ##### 10:24:52 INFO - Running pre-action listener: _resource_record_pre_action 10:24:52 INFO - Running main action method: create_virtualenv 10:24:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:24:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:24:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:24:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:24:52 INFO - Using real prefix '/usr' 10:24:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:24:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:24:54 INFO - Installing pip.................done. 10:24:54 INFO - Return code: 0 10:24:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:24:54 INFO - Using env: {'DISPLAY': ':0', 10:24:54 INFO - 'HOME': '/home/cltbld', 10:24:54 INFO - 'LANG': 'en_US.UTF-8', 10:24:54 INFO - 'LANGUAGE': 'en_US:en', 10:24:54 INFO - 'LOGNAME': 'cltbld', 10:24:54 INFO - 'MAIL': '/var/mail/cltbld', 10:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:54 INFO - 'MOZ_NO_REMOTE': '1', 10:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:54 INFO - 'NO_EM_RESTART': '1', 10:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:54 INFO - 'PWD': '/builds/slave/test', 10:24:54 INFO - 'SHELL': '/bin/bash', 10:24:54 INFO - 'SHLVL': '1', 10:24:54 INFO - 'TERM': 'linux', 10:24:54 INFO - 'TMOUT': '86400', 10:24:54 INFO - 'USER': 'cltbld', 10:24:54 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:54 INFO - '_': '/tools/buildbot/bin/python'} 10:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:54 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 10:24:54 INFO - Cleaning up... 10:24:54 INFO - Return code: 0 10:24:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:24:54 INFO - Using env: {'DISPLAY': ':0', 10:24:54 INFO - 'HOME': '/home/cltbld', 10:24:54 INFO - 'LANG': 'en_US.UTF-8', 10:24:54 INFO - 'LANGUAGE': 'en_US:en', 10:24:54 INFO - 'LOGNAME': 'cltbld', 10:24:54 INFO - 'MAIL': '/var/mail/cltbld', 10:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:54 INFO - 'MOZ_NO_REMOTE': '1', 10:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:54 INFO - 'NO_EM_RESTART': '1', 10:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:54 INFO - 'PWD': '/builds/slave/test', 10:24:54 INFO - 'SHELL': '/bin/bash', 10:24:54 INFO - 'SHLVL': '1', 10:24:54 INFO - 'TERM': 'linux', 10:24:54 INFO - 'TMOUT': '86400', 10:24:54 INFO - 'USER': 'cltbld', 10:24:54 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:54 INFO - '_': '/tools/buildbot/bin/python'} 10:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:55 INFO - Downloading/unpacking psutil>=3.1.1 10:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:57 INFO - Installing collected packages: psutil 10:24:57 INFO - Running setup.py install for psutil 10:24:57 INFO - building 'psutil._psutil_linux' extension 10:24:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:24:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:24:57 INFO - building 'psutil._psutil_posix' extension 10:24:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:24:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:24:57 INFO - Successfully installed psutil 10:24:57 INFO - Cleaning up... 10:24:57 INFO - Return code: 0 10:24:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:24:57 INFO - Using env: {'DISPLAY': ':0', 10:24:57 INFO - 'HOME': '/home/cltbld', 10:24:57 INFO - 'LANG': 'en_US.UTF-8', 10:24:57 INFO - 'LANGUAGE': 'en_US:en', 10:24:57 INFO - 'LOGNAME': 'cltbld', 10:24:57 INFO - 'MAIL': '/var/mail/cltbld', 10:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:57 INFO - 'MOZ_NO_REMOTE': '1', 10:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:57 INFO - 'NO_EM_RESTART': '1', 10:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:57 INFO - 'PWD': '/builds/slave/test', 10:24:57 INFO - 'SHELL': '/bin/bash', 10:24:57 INFO - 'SHLVL': '1', 10:24:57 INFO - 'TERM': 'linux', 10:24:57 INFO - 'TMOUT': '86400', 10:24:57 INFO - 'USER': 'cltbld', 10:24:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:57 INFO - '_': '/tools/buildbot/bin/python'} 10:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:24:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:24: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 10:24: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 10:24: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 10:24: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 10:24: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 10:24: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 10:24:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:24:59 INFO - Installing collected packages: mozsystemmonitor 10:24:59 INFO - Running setup.py install for mozsystemmonitor 10:24:59 INFO - Successfully installed mozsystemmonitor 10:24:59 INFO - Cleaning up... 10:24:59 INFO - Return code: 0 10:24:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:24:59 INFO - Using env: {'DISPLAY': ':0', 10:24:59 INFO - 'HOME': '/home/cltbld', 10:24:59 INFO - 'LANG': 'en_US.UTF-8', 10:24:59 INFO - 'LANGUAGE': 'en_US:en', 10:24:59 INFO - 'LOGNAME': 'cltbld', 10:24:59 INFO - 'MAIL': '/var/mail/cltbld', 10:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:59 INFO - 'MOZ_NO_REMOTE': '1', 10:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:24:59 INFO - 'NO_EM_RESTART': '1', 10:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:59 INFO - 'PWD': '/builds/slave/test', 10:24:59 INFO - 'SHELL': '/bin/bash', 10:24:59 INFO - 'SHLVL': '1', 10:24:59 INFO - 'TERM': 'linux', 10:24:59 INFO - 'TMOUT': '86400', 10:24:59 INFO - 'USER': 'cltbld', 10:24:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:59 INFO - '_': '/tools/buildbot/bin/python'} 10:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:00 INFO - Downloading/unpacking jsonschema==2.5.1 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:25:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:25: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 10:25: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 10:25: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 10:25: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 10:25: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 10:25: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 10:25:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:25:02 INFO - warning: no files found matching '*.txt' 10:25:02 INFO - no previously-included directories found matching 'build' 10:25:02 INFO - no previously-included directories found matching 'dist' 10:25:02 INFO - no previously-included directories found matching '.git*' 10:25:02 INFO - Installing collected packages: jsonschema, functools32 10:25:02 INFO - Running setup.py install for functools32 10:25:02 INFO - warning: no files found matching '*.txt' 10:25:02 INFO - no previously-included directories found matching 'build' 10:25:02 INFO - no previously-included directories found matching 'dist' 10:25:02 INFO - no previously-included directories found matching '.git*' 10:25:02 INFO - Successfully installed jsonschema functools32 10:25:02 INFO - Cleaning up... 10:25:02 INFO - Return code: 0 10:25:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:25:02 INFO - Using env: {'DISPLAY': ':0', 10:25:02 INFO - 'HOME': '/home/cltbld', 10:25:02 INFO - 'LANG': 'en_US.UTF-8', 10:25:02 INFO - 'LANGUAGE': 'en_US:en', 10:25:02 INFO - 'LOGNAME': 'cltbld', 10:25:02 INFO - 'MAIL': '/var/mail/cltbld', 10:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:02 INFO - 'MOZ_NO_REMOTE': '1', 10:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:02 INFO - 'NO_EM_RESTART': '1', 10:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:02 INFO - 'PWD': '/builds/slave/test', 10:25:02 INFO - 'SHELL': '/bin/bash', 10:25:02 INFO - 'SHLVL': '1', 10:25:02 INFO - 'TERM': 'linux', 10:25:02 INFO - 'TMOUT': '86400', 10:25:02 INFO - 'USER': 'cltbld', 10:25:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:02 INFO - '_': '/tools/buildbot/bin/python'} 10:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:25:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:25:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:05 INFO - Downloading docopt-0.6.1.tar.gz 10:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:25:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:25:05 INFO - Running setup.py install for blobuploader 10:25:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:25:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:25:05 INFO - Running setup.py install for requests 10:25:05 INFO - Running setup.py install for docopt 10:25:05 INFO - Successfully installed blobuploader requests docopt 10:25:05 INFO - Cleaning up... 10:25:05 INFO - Return code: 0 10:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25: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')]} 10:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25: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')]} 10:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:05 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 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:25:05 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 10:25:05 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 10:25:05 INFO - Using env: {'DISPLAY': ':0', 10:25:05 INFO - 'HOME': '/home/cltbld', 10:25:05 INFO - 'LANG': 'en_US.UTF-8', 10:25:05 INFO - 'LANGUAGE': 'en_US:en', 10:25:05 INFO - 'LOGNAME': 'cltbld', 10:25:05 INFO - 'MAIL': '/var/mail/cltbld', 10:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:05 INFO - 'MOZ_NO_REMOTE': '1', 10:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:05 INFO - 'NO_EM_RESTART': '1', 10:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:05 INFO - 'PWD': '/builds/slave/test', 10:25:05 INFO - 'SHELL': '/bin/bash', 10:25:05 INFO - 'SHLVL': '1', 10:25:05 INFO - 'TERM': 'linux', 10:25:05 INFO - 'TMOUT': '86400', 10:25:05 INFO - 'USER': 'cltbld', 10:25:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:05 INFO - '_': '/tools/buildbot/bin/python'} 10:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:06 INFO - Running setup.py (path:/tmp/pip-K1C11W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:06 INFO - Running setup.py (path:/tmp/pip-6AeXRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:06 INFO - Running setup.py (path:/tmp/pip-EZhzuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:06 INFO - Running setup.py (path:/tmp/pip-B94SR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:06 INFO - Running setup.py (path:/tmp/pip-8GvUBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:06 INFO - Running setup.py (path:/tmp/pip-XoDKLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:06 INFO - Running setup.py (path:/tmp/pip-wYUreP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:06 INFO - Running setup.py (path:/tmp/pip-tGBcn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:06 INFO - Running setup.py (path:/tmp/pip-Tyo7L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:06 INFO - Running setup.py (path:/tmp/pip-OJULui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:06 INFO - Running setup.py (path:/tmp/pip-X7Jvsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:06 INFO - Running setup.py (path:/tmp/pip-N6Nq_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:07 INFO - Running setup.py (path:/tmp/pip-wqENFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:07 INFO - Running setup.py (path:/tmp/pip-wHjfcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:07 INFO - Running setup.py (path:/tmp/pip-DHA3G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:07 INFO - Running setup.py (path:/tmp/pip-FU9lwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:07 INFO - Running setup.py (path:/tmp/pip-qUJoaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:25:07 INFO - Running setup.py install for manifestparser 10:25:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:25:07 INFO - Running setup.py install for mozcrash 10:25:07 INFO - Running setup.py install for mozdebug 10:25:07 INFO - Running setup.py install for mozdevice 10:25:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:25:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:25:07 INFO - Running setup.py install for mozfile 10:25:07 INFO - Running setup.py install for mozhttpd 10:25:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Running setup.py install for mozinfo 10:25:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Running setup.py install for mozInstall 10:25:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Running setup.py install for mozleak 10:25:08 INFO - Running setup.py install for mozlog 10:25:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Running setup.py install for moznetwork 10:25:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Running setup.py install for mozprocess 10:25:08 INFO - Running setup.py install for mozprofile 10:25:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Running setup.py install for mozrunner 10:25:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:25:08 INFO - Running setup.py install for mozscreenshot 10:25:09 INFO - Running setup.py install for moztest 10:25:09 INFO - Running setup.py install for mozversion 10:25:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:25:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:25:09 INFO - Cleaning up... 10:25:09 INFO - Return code: 0 10:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:25:09 INFO - Using env: {'DISPLAY': ':0', 10:25:09 INFO - 'HOME': '/home/cltbld', 10:25:09 INFO - 'LANG': 'en_US.UTF-8', 10:25:09 INFO - 'LANGUAGE': 'en_US:en', 10:25:09 INFO - 'LOGNAME': 'cltbld', 10:25:09 INFO - 'MAIL': '/var/mail/cltbld', 10:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:09 INFO - 'MOZ_NO_REMOTE': '1', 10:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:09 INFO - 'NO_EM_RESTART': '1', 10:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:09 INFO - 'PWD': '/builds/slave/test', 10:25:09 INFO - 'SHELL': '/bin/bash', 10:25:09 INFO - 'SHLVL': '1', 10:25:09 INFO - 'TERM': 'linux', 10:25:09 INFO - 'TMOUT': '86400', 10:25:09 INFO - 'USER': 'cltbld', 10:25:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:09 INFO - '_': '/tools/buildbot/bin/python'} 10:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:25:09 INFO - Running setup.py (path:/tmp/pip-zN7HqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:25:09 INFO - Running setup.py (path:/tmp/pip-atl_CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:25:09 INFO - Running setup.py (path:/tmp/pip-mGjaQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:25:09 INFO - Running setup.py (path:/tmp/pip-U0g3Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:25:09 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)) 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:25:09 INFO - Running setup.py (path:/tmp/pip-demaF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:25:09 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)) 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:25:09 INFO - Running setup.py (path:/tmp/pip-hb6Hm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:25:09 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)) 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:25:09 INFO - Running setup.py (path:/tmp/pip-Emhawd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:25:09 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)) 10:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:25:09 INFO - Running setup.py (path:/tmp/pip-FbQk3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:25:10 INFO - Running setup.py (path:/tmp/pip-aOaVMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:25:10 INFO - Running setup.py (path:/tmp/pip-L4eiyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:25:10 INFO - Running setup.py (path:/tmp/pip-gA53N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:25:10 INFO - Running setup.py (path:/tmp/pip-5lreAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:25:10 INFO - Running setup.py (path:/tmp/pip-S6rwbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:25:10 INFO - Running setup.py (path:/tmp/pip-H9rgcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:10 INFO - Running setup.py (path:/tmp/pip-De4fBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:25:10 INFO - Running setup.py (path:/tmp/pip-W4Omr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:25:10 INFO - Running setup.py (path:/tmp/pip-GrzJ2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:25:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:25:10 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 10:25:10 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 10:25:10 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 10:25:10 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 10:25:10 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 10:25:10 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 10:25:12 INFO - Downloading blessings-1.6.tar.gz 10:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:25:12 INFO - Installing collected packages: blessings 10:25:12 INFO - Running setup.py install for blessings 10:25:12 INFO - Successfully installed blessings 10:25:12 INFO - Cleaning up... 10:25:12 INFO - Return code: 0 10:25:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:13 INFO - Reading from file tmpfile_stdout 10:25:13 INFO - Current package versions: 10:25:13 INFO - argparse == 1.2.1 10:25:13 INFO - blessings == 1.6 10:25:13 INFO - blobuploader == 1.2.4 10:25:13 INFO - docopt == 0.6.1 10:25:13 INFO - functools32 == 3.2.3-2 10:25:13 INFO - jsonschema == 2.5.1 10:25:13 INFO - manifestparser == 1.1 10:25:13 INFO - mozInstall == 1.12 10:25:13 INFO - mozcrash == 0.17 10:25:13 INFO - mozdebug == 0.1 10:25:13 INFO - mozdevice == 0.48 10:25:13 INFO - mozfile == 1.2 10:25:13 INFO - mozhttpd == 0.7 10:25:13 INFO - mozinfo == 0.9 10:25:13 INFO - mozleak == 0.1 10:25:13 INFO - mozlog == 3.2 10:25:13 INFO - moznetwork == 0.27 10:25:13 INFO - mozprocess == 0.22 10:25:13 INFO - mozprofile == 0.28 10:25:13 INFO - mozrunner == 6.11 10:25:13 INFO - mozscreenshot == 0.1 10:25:13 INFO - mozsystemmonitor == 0.3 10:25:13 INFO - moztest == 0.7 10:25:13 INFO - mozversion == 1.4 10:25:13 INFO - psutil == 3.1.1 10:25:13 INFO - requests == 1.2.3 10:25:13 INFO - wsgiref == 0.1.2 10:25:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:25:13 INFO - Using env: {'DISPLAY': ':0', 10:25:13 INFO - 'HOME': '/home/cltbld', 10:25:13 INFO - 'LANG': 'en_US.UTF-8', 10:25:13 INFO - 'LANGUAGE': 'en_US:en', 10:25:13 INFO - 'LOGNAME': 'cltbld', 10:25:13 INFO - 'MAIL': '/var/mail/cltbld', 10:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:13 INFO - 'MOZ_NO_REMOTE': '1', 10:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:13 INFO - 'NO_EM_RESTART': '1', 10:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:13 INFO - 'PWD': '/builds/slave/test', 10:25:13 INFO - 'SHELL': '/bin/bash', 10:25:13 INFO - 'SHLVL': '1', 10:25:13 INFO - 'TERM': 'linux', 10:25:13 INFO - 'TMOUT': '86400', 10:25:13 INFO - 'USER': 'cltbld', 10:25:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:13 INFO - '_': '/tools/buildbot/bin/python'} 10:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:25:13 INFO - Cleaning up... 10:25:13 INFO - Return code: 0 10:25:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:25:13 INFO - Using env: {'DISPLAY': ':0', 10:25:13 INFO - 'HOME': '/home/cltbld', 10:25:13 INFO - 'LANG': 'en_US.UTF-8', 10:25:13 INFO - 'LANGUAGE': 'en_US:en', 10:25:13 INFO - 'LOGNAME': 'cltbld', 10:25:13 INFO - 'MAIL': '/var/mail/cltbld', 10:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:13 INFO - 'MOZ_NO_REMOTE': '1', 10:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:13 INFO - 'NO_EM_RESTART': '1', 10:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:13 INFO - 'PWD': '/builds/slave/test', 10:25:13 INFO - 'SHELL': '/bin/bash', 10:25:13 INFO - 'SHLVL': '1', 10:25:13 INFO - 'TERM': 'linux', 10:25:13 INFO - 'TMOUT': '86400', 10:25:13 INFO - 'USER': 'cltbld', 10:25:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:13 INFO - '_': '/tools/buildbot/bin/python'} 10:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:25:13 INFO - Cleaning up... 10:25:13 INFO - Return code: 0 10:25:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0bcf5ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', '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 10:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:25:13 INFO - Using env: {'DISPLAY': ':0', 10:25:13 INFO - 'HOME': '/home/cltbld', 10:25:13 INFO - 'LANG': 'en_US.UTF-8', 10:25:13 INFO - 'LANGUAGE': 'en_US:en', 10:25:13 INFO - 'LOGNAME': 'cltbld', 10:25:13 INFO - 'MAIL': '/var/mail/cltbld', 10:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:13 INFO - 'MOZ_NO_REMOTE': '1', 10:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:13 INFO - 'NO_EM_RESTART': '1', 10:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:13 INFO - 'PWD': '/builds/slave/test', 10:25:13 INFO - 'SHELL': '/bin/bash', 10:25:13 INFO - 'SHLVL': '1', 10:25:13 INFO - 'TERM': 'linux', 10:25:13 INFO - 'TMOUT': '86400', 10:25:13 INFO - 'USER': 'cltbld', 10:25:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:13 INFO - '_': '/tools/buildbot/bin/python'} 10:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:25:13 INFO - Downloading/unpacking flake8 10:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:25:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:25:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:25:16 INFO - no previously-included directories found matching 'docs/_build' 10:25:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:25:16 INFO - Running setup.py install for pep8 10:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:25:16 INFO - no previously-included directories found matching 'docs/_build' 10:25:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:25:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:25:16 INFO - Cleaning up... 10:25:16 INFO - Return code: 0 10:25:16 INFO - Running post-action listener: _resource_record_post_action 10:25:16 INFO - Running post-action listener: _start_resource_monitoring 10:25:16 INFO - Starting resource monitoring. 10:25:16 INFO - ##### 10:25:16 INFO - ##### Finished create-virtualenv step (success) 10:25:16 INFO - ##### 10:25:16 INFO - ##### 10:25:16 INFO - ##### Running install step. 10:25:16 INFO - ##### 10:25:16 INFO - Running pre-action listener: _resource_record_pre_action 10:25:16 INFO - Running main action method: install 10:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:25:16 INFO - Reading from file tmpfile_stdout 10:25:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:25:16 INFO - Reading from file tmpfile_stdout 10:25:16 INFO - Output received: 10:25:16 INFO - Usage: mozinstall [options] installer 10:25:16 INFO - Options: 10:25:16 INFO - -h, --help show this help message and exit 10:25:16 INFO - -d DEST, --destination=DEST 10:25:16 INFO - Directory to install application into. [default: 10:25:16 INFO - "/builds/slave/test"] 10:25:16 INFO - --app=APP Application being installed. [default: firefox] 10:25:16 INFO - mkdir: /builds/slave/test/build/application 10:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:25:32 INFO - Reading from file tmpfile_stdout 10:25:32 INFO - Output received: 10:25:32 INFO - /builds/slave/test/build/application/firefox/firefox 10:25:32 INFO - Running post-action listener: _resource_record_post_action 10:25:32 INFO - ##### 10:25:32 INFO - ##### Finished install step (success) 10:25:32 INFO - ##### 10:25:32 INFO - ##### 10:25:32 INFO - ##### Running run-tests step. 10:25:32 INFO - ##### 10:25:32 INFO - Running pre-action listener: _resource_record_pre_action 10:25:32 INFO - Running main action method: run_tests 10:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:25:32 INFO - Python 2.7.3 10:25:32 INFO - Return code: 0 10:25:32 INFO - grabbing minidump binary from tooltool 10:25:32 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')]} 10:25:32 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 0x21102e0>, '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 0x207c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:25:32 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 10:25:32 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 10:25:32 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 10:25:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:25:32 INFO - Return code: 0 10:25:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:25:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:25:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:25:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:25:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:25:33 INFO - Return code: 0 10:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 10:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 10:25:33 INFO - Using env: {'DISPLAY': ':0', 10:25:33 INFO - 'HOME': '/home/cltbld', 10:25:33 INFO - 'LANG': 'en_US.UTF-8', 10:25:33 INFO - 'LANGUAGE': 'en_US:en', 10:25:33 INFO - 'LOGNAME': 'cltbld', 10:25:33 INFO - 'MAIL': '/var/mail/cltbld', 10:25:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:25:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:25:33 INFO - 'MOZ_NO_REMOTE': '1', 10:25:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:25:33 INFO - 'NO_EM_RESTART': '1', 10:25:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:25:33 INFO - 'PWD': '/builds/slave/test', 10:25:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:25:33 INFO - 'SHELL': '/bin/bash', 10:25:33 INFO - 'SHLVL': '1', 10:25:33 INFO - 'TERM': 'linux', 10:25:33 INFO - 'TMOUT': '86400', 10:25:33 INFO - 'USER': 'cltbld', 10:25:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814', 10:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:25:33 INFO - '_': '/tools/buildbot/bin/python'} 10:25:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 10:25:34 INFO - mozversion application_buildid: 20160607090033 10:25:34 INFO - mozversion application_changeset: ee6ea28c089918834cb26b67c77653114af3dce5 10:25:34 INFO - mozversion application_display_name: Nightly 10:25:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:25:34 INFO - mozversion application_name: Firefox 10:25:34 INFO - mozversion application_remotingname: firefox 10:25:34 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 10:25:34 INFO - mozversion application_vendor: Mozilla 10:25:34 INFO - mozversion application_version: 50.0a1 10:25:34 INFO - mozversion platform_buildid: 20160607090033 10:25:34 INFO - mozversion platform_changeset: ee6ea28c089918834cb26b67c77653114af3dce5 10:25:34 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 10:25:34 INFO - mozversion platform_version: 50.0a1 10:25:34 INFO - using testdate: 1465320334 10:25:34 INFO - actual date: 1465320334 10:25:34 INFO - starting webserver on 'localhost:37266' 10:25:34 INFO - SUITE-START | Running 2 tests 10:25:34 INFO - TEST-START | dromaeo_css 10:25:34 INFO - operating with platform_type : linux_ 10:25:34 INFO - Initialising browser for dromaeo_css test... 10:25:34 INFO - TEST-INFO | started process 21569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgCZjZ/profile http://localhost:37266/getInfo.html) 10:25:38 INFO - PROCESS | 21569 | __metrics Screen width/height:1600/1200 10:25:38 INFO - PROCESS | 21569 | colorDepth:24 10:25:38 INFO - PROCESS | 21569 | Browser inner width/height: 1024/697 10:25:38 INFO - PROCESS | 21569 | __metrics 10:25:39 ERROR - PROCESS | 21569 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:25:39 INFO - PROCESS | 21569 | console.error: PushService: 10:25:39 INFO - PROCESS | 21569 | stateChangeProcessEnqueue: Error transitioning state 10:25:39 INFO - PROCESS | 21569 | UnknownError 10:25:40 INFO - TEST-INFO | 21569: exit 0 10:25:40 INFO - Browser initialized. 10:25:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:25:40 INFO - TEST-INFO | started process 21650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgCZjZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:52 INFO - PROCESS | 21650 | RSS: Main: 161423360 10:25:52 INFO - PROCESS | 21650 | 10:26:43 INFO - PROCESS | 21650 | 1465320403561 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] 10:28:55 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37266/tests/dromaeo/cssquery-ext.html) 10:28:56 INFO - PROCESS | 21650 | RSS: Main: 270192640 10:28:56 INFO - PROCESS | 21650 | 10:31:59 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-ext.html (next: http://localhost:37266/tests/dromaeo/cssquery-jquery.html) 10:31:59 INFO - PROCESS | 21650 | RSS: Main: 239415296 10:31:59 INFO - PROCESS | 21650 | 10:35:01 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37266/tests/dromaeo/cssquery-mootools.html) 10:35:02 INFO - PROCESS | 21650 | RSS: Main: 242601984 10:35:02 INFO - PROCESS | 21650 | 10:38:04 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37266/tests/dromaeo/cssquery-prototype.html) 10:38:05 INFO - PROCESS | 21650 | RSS: Main: 233443328 10:38:05 INFO - PROCESS | 21650 | 10:41:08 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37266/tests/dromaeo/cssquery-yui.html) 10:41:08 INFO - PROCESS | 21650 | RSS: Main: 214724608 10:41:08 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:37266/tests/dromaeo/cssquery-yui.html (next: http://localhost:37266/tests/dromaeo/cssquery-dojo.html) 10:44:11 INFO - PROCESS | 21650 | RSS: Main: 275312640 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | __start_tp_report 10:44:11 INFO - PROCESS | 21650 | _x_x_mozilla_page_load 10:44:11 INFO - PROCESS | 21650 | _x_x_mozilla_page_load_details 10:44:11 INFO - PROCESS | 21650 | |i|pagename|runs| 10:44:11 INFO - PROCESS | 21650 | |0;dojo.html;2585.508753336866;2624.4882247961655;2642.048862409533;2657.3755167535624;2658.215826331232;4508.053308805147;4580.58774710276;4648.395708557887;4699.483056863746;4752.643551733621;4551.385562949001;4612.492625811158;4630;4635.605973492257;4645.605123564501;4274.893127671802;4276.50820155683;4289.785510724467;4297.140571885635;4315.546867578906;4319.524852266248;4359.956400436003;4396.296592545194;4413.3159360299205;4423.336499525081;4326.134773045404;4369.257226271526;4375.540568240337;4381.649468042581;4406.889827754299;4154.065335299563;4185.351270553069;4223.408722778813;4223.66210703143;4226.957730422687;4203.810828512725;4219.831206751726;4263.040815816447;4270.081932384553;4314.741115533078;4599.356090147382;4608.33179189019;4613.077384523109;4614.72311661298;4615;4833.10587541306;4888.486708895551;4944.233643785219;4953.653244272902;5015.648904576681;5014.548690617862;5018.146915024455;5034.270030845543;5043.167877300241;5055.51972562606;4551.749653769009;4648.1865673507;4653.86038418848;4697.506761790031;4705.458872229703;4996.975015124901;5069.239614057921;5071.087204303187;5086.516780905808;5157.896842063138;4899.363082799285;4899.510048995143;4941.407031156285;4946.233333833262;4960.70235785854;4860.95139048605;4861.368022157097;4971.428285747185;5020.422651395063;5022.246663000579;4817.590504807061;4826.0589185108565;4850.345203397566;4853.223484242504;4897.4857639947295;4809.78355973982;4815.133276010351;4818.10864989978;4819.421669399624;4850.587700045465;4105.548389677133;4148.274052040881;4153.958460415418;4154.335306350969;4193.30810416284;3675.7978311192605;3676.356637588411;3679.0434487033563;3711.350513660099;3749.531308586427;4339.934900976488;4370.497392799805;4373.409589705413;4413.558644135625;4422.867313980586;4867.050925069578;4945.134601444733;4987.0524600325825;5040.218766091261;5045.9747701261995;4356.106998065389;4374.934375984363;4379.956200438019;4407.27279998803;4419.668524860648;4463.866084017484;4497.190505708938;4499.842505512292;4514.052049069666;4550.0217453247715;4617.930731039037;4673.719576825401;4719.197736384823;4732.982408782128;4734.55021772931;5051.747412629427;5057.064443078042;5067.847964561069;5069.9746501267255;5121.129408000724;4743.549362810528;4750.596199323097;4756.453007904135;4761.362454755608;4807.134715751198;4800.7599620019555;4854.538818812207;4900.411950565955;4926.556609905126;4987.9002419950675;4980.825671101494;5000.499950004971;5003.049420610072;5004.949950500449;5034.119029169954;4841.733704646278;4868.561829435368;4879.024195160911;4879.780409881493;4928.507149285043;4746.288056791509;4797.064572408486;4840.443349014909;4859.829905953275;4879.975600121977;4805.495422980537;4810.182269014346;4851.417829860439;4857.53853383928;4867.415910090812;4759.309900064402;4882.145624515767;4889.266610008527;4953;4960.156773348467;4724.71651700899;4725.314829349656;4813.181759100891;4821.325014498043;4842.7820748065715 10:44:11 INFO - PROCESS | 21650 | |1;ext.html;540.3911982729959;564.875727339985;569.9886002279957;578.482258378751;590.7636945221909;29777.55333669994;41157.17685646285;42148.367774483406;42193.36709949353;46234.07531849361;37364.439533406956;37616;37777;37797.244055118885;37819.4327085094;7455.4781165318445;7851.960740196291;8022;8024.919750802475;8027.397945154107;7388.556686598795;7661.387089032892;7664.731734389297;10125.088742013217;10469.11012563933;10390.064894159525;10460.895391046106;10464;10469.4765261737;10470.895291047107;10325.277230593823;10370.63702770407;10375.481225938673;10377.948110259438;10381;7534.434917381218;7820.178881217447;7820.335271501929;9939.453330066843;10384.688459346156;38833;39393.80303098466;39424.40863387052;39466.802665986484;39487.21025579472;2770.598263251817;2945.5581662750546;2958.6153800005864;3360.2029706431576;3467.2025434150287;29226.707732922612;29469.852650736608;30441.543376849364;31253;31436.52845207324;3308.354870800195;3406.9488957665653;3428.160100775301;3435.519027336175;3435.656434356569;245709;247635;248467;248582;249003;53750.731246343516;54512.454875451534;54513.45486545084;54570;54686;57123;57293.427065729644;57320;57596;57619.71190144023;13778.173309601456;14219.786703199461;14226.644333891736;14302.140721706319;14321.427142914376;9606.375585586915;10757.085647719874;10812.837807432894;10823.134149268197;10829.945850270698;17350.826491734922;17958.820411795714;18006.639867202844;18720.90639546821;18763;6113.663748493876;6202.813915582449;6203.627782333075;6246.3441338659695;6334.429901308904;861.5347712235323;925.0656836595087;977.9559919803626;1007.9445630490246;1019.23557332001;27408;28353;28756;30039.24901877427;30542.38915221683;963.6819849449805;1001.4792307999945;1032.3547782635853;1045.231754660324;1063.9202059845543;14485.348159332856;15172;15179.772303415457;15392.92303538475;15484.767728484081;389198;389449;392500;392825;393950;50243;50348;50528;50533.494665053615;50540.74729626328;1080.4651697409674;1139.834723965037;1180.492388273051;1206.3244583033354;1246.4328730427815;27636.585451217845;29124.35731056161;29184.416311673223;29267.707322926497;29690.406191876475;40510;40964.38553421642;41015.589844101174;41019;41137.58862411338;298886;300804;301312;301348;301718;22613;25608.359791005372;25617;25813.483730325665;26320;42795.57204427916;42836.57163428326;43248.135037299704;43607.56392436162;43699.78150109229;35026.474602880466;35687.10782230361;36064.63935360613;36141.63858361383;36433.99613021309;35812.104697382776;36265;36278.09304767402;36519.26961460809;36544.45183322199;35880.820595896854;36128.63871361358;37357.25285494329;38222.23555528929;38363;31520.211994700316;33632.327353453285;33648.49527257142;34042;34110.48834267438;24750.504989899742;25769;26127.346816329744;26840.32899177536;27212.591811122453 10:44:11 INFO - PROCESS | 21650 | |2;jquery.html;378.2769484995845;382.426360459311;382.9999999999999;393.877897851666;393.9133390654055;15670.84329156708;16809;17554.297828086877;17680.64638707225;17710.645787084268;16111.83888161118;16475.423360182394;16597.751033734505;16911.40810071648;16922.323107075703;4645.465771436286;4781.521847815226;4806.519348065183;4815.5906747926465;4822.397200349957;3548.574171099459;3715.7584756990846;5187.455317191679;5483.259759932398;5484.725763711818;5526.530244929186;5528.364238112608;5534.335879694442;5557.277553917985;5558.194061861028;5842.707864606753;6070.817875463699;6186.288576813679;6193;6194.380561943814;5237.921431178535;5419;5455.099908515091;5493.615446918718;5495;18824.341148059888;19841.404757857286;20426.38720838377;20549;20629.4842628934;1929;2333.8249631277554;2346.389938615955;2422.92731218062;2430.8419952703016;8821.07378725231;8947.597358118901;8963.372563920528;8999.280057595442;9343.532823358804;1697.3210715713813;1736.8263173682658;1769.7256925176619;1800.0459756329035;1804.8014718380969;67864;69863;69893;71288.2871171292;73200.26799731988;10045.899541004643;10117.797644047225;10136.594536218468;10291.279610427198;10465.633702820516;14089.647758806112;14142.080764750259;14200.502982395567;14222.502212422516;14229.14625122496;6623.370779775913;6649;6718.697658605374;6747.156605424322;6803.7618683345845;6453.386928241809;6515.4787616990525;6617.867642647217;6719.0593316935665;6729.528932974645;4276.2302785498905;4296.742195468282;4358.019445624709;4389.341598760211;4398.978005110018;1580.138824340737;1669.2238109279;1790.2838864454322;1791.3551121596215;1803.765510483655;830.8379865926207;858.1418581418582;864.9654013839375;866.787637028932;890.2922176869405;16410.1794910254;16533.6693266134;16720.58198545022;16890.324387024382;17079.914600426917;814.8288859339486;846.2806614377853;933.4772527384687;936.0826390137703;936.9812603747887;9051.773705657279;9673.806523869624;9702.805943881083;9709;9824.754381140387;311939.44030280155;314770;431400;435404;438942;85727.57136214279;88617.55691221502;90505.94940505897;92796.07203928009;92870;913.8857642794651;924.4961495984704;958.3291695812959;960.9711708648751;974.201155052864;15537.145456999973;15584.220788960733;15658.843411566195;15795.605109871885;16174.272157752694;36874.078148046516;37254.8137259312;37294.62705372911;37603.81198093992;38418;49721.75139124281;50880.236796447345;52485.475145248056;52747;53187.734061329444;7539.359154471931;7559.203980099503;7600.391968642606;7785.299323060725;7983.600819959095;8519.701810436605;10807.67576972692;11256.155788316073;11964.521419143137;12198;10080.596776128872;10195.286329957129;10380.221483388625;10483.895161048293;10572.048515633629;10316.226283028953;10370.585176592851;10439.37363758177;10491.265611407434;10555.102816260704;9571.712848614552;10368.585256589651;10449.582016719247;10672.519736611715;10762.677119686421;7475.551466912003;7637.618119094134;7649.388048955959;7654.808629784077;7940.28537431634;8085.555294458862;9193.448393096436;10428.165746740395;10572.154227661922;11147.331160130418 10:44:11 INFO - PROCESS | 21650 | |3;mootools.html;1187.4181650991006;1355.6610847288177;1398.3148257353894;1506.337211626884;1705.2326453096102;6649.069130321753;7424.591647459394;7699.730509432171;7705.961470192641;7868.606569671522;7685.116211635664;7706.383489320855;7723.111842138156;7767.223277672244;7774.494657847236;2214.291426743439;2240.451089483071;2243.25972429098;2244.80919121874;2245.4274160089235;2163.102312540294;2194.0565556810566;2195.6157672407344;2196.3850121965875;2200.108955872874;2209.723784526934;2219.4673278413225;2229.2754854672216;2234.821214302852;2245.4161917901383;2139.711138996231;2157.6655618379177;2159.7084393606897;2174.065151984646;2175.869447833127;2096.423483542023;2106.799854013866;2109.3039297032096;2114.1754715660904;2114.196605289995;7488.625568721596;7596.848063038764;7651.387888968869;7658.157602663702;7687.461877668566;4404.427424434803;4564.520725323827;4571.108633816407;4577.9542204577865;4582.289745089483;2802.467531169071;3033.7572994160414;3067.1105379439937;3081.4607443697264;3087.72210501056;915.3043686798015;923.4643906534261;1017.3539802225566;1021.9948900255451;1053.425882893817;10444.373337599693;10447.68656940293;10449.373037617766;10452.425116618508;10475.319104258198;3946.565877753445;4032.213718324957;4246.363045543131;4247.851325203603;4248.978755106266;8280.792980175544;8361.83276334482;8366.958165209135;8396.160383961555;8407.789805254917;4486.439195100613;4497.617702495259;4501.6848820582245;4510.977445112753;4514.413126293561;3641.0715267606593;3656.4880916671686;4104.343305071175;4107.075907920694;4168.145530166309;3405.3870303345634;3432.9313413731584;3496.615372309044;3512.964870351315;3618.493410922473;983.1692220074026;983.6557204978201;992.0773680477225;993.8509223616371;1041.5521325829966;666.4435196610884;705.5837056136904;715.9534630249017;733.4792297468857;734.9559026458429;4465.709728867613;4527.456705195397;4578.427696537933;4634.652401069866;4782.426108866958;397.3443817700759;407.83482689510794;409.87293938878446;414.64340667026335;421.7427369304722;3184.824834634071;3253.788503747296;3262.168147122469;3273.7544684148306;3325.73394128474;9130.771730706652;9254.583543740548;9597.90402095984;9600;9634;9453.291003174789;9521.19069879068;9523.047695230422;9527.761805954906;9531.571079301448;6955.791326260221;6998.4751143664425;7104.147502299654;7123.821904452327;7137.85724285501;4660.370849935215;4683.765811709469;4701.764911754331;4732.100900828831;4744.359511465908;8844.115588441362;8867.157620026088;8883.289336852908;8929.285657147282;8955.820883582162;8397.748067557983;8652.740417787476;8673.089325620718;8682.088380719933;8976.775580610538;6588.40704336612;6812.659367031728;6930.584164950119;6966.895496567454;6982.266861979419;7393.07586551681;7410.703571857281;7460.925390746023;7468.887966680612;7503.737369192052;6378.138951241523;6480.546361754632;6533.477321814148;6577.14497115372;6612.140421745143;6076.392360763888;6090;6105.511559075352;6169.753209871555;6209.813705588839;5780.7398667060925;5833.387494313036;5854.2389489366105;5859.472647461749;5870.677112758668;3894.4937158169255;3945.861894833667;4038.7374820636564;4154.522229943595;4176.248275310473;3888.650021498079;3964.385520244367;3999.680025597887;4011.5959414204794;4038.757674539537 10:44:11 INFO - PROCESS | 21650 | |4;prototype.html;295.62308057227034;297.8034497231827;298.82817380006503;306.3688801069796;312.3300520383777;4737.531365276766;4741.525847415257;4755.3104799804005;4755.429348478183;4768.760122368183;4647.53524647536;4688.343631891529;4699;4718.245080787075;4728.645351598627;3570.9107272318142;3644.8906532803926;3668.137987572918;3764.9435258471144;3784.6026167252453;3744.3634582121103;3748.475213470116;3752.587215406303;3765.8722821605706;3774.792386418746;3567.3935430976667;3721.869734559291;3725.7019438444995;3730.608286129958;3730.9067273318115;3609.9097522561883;3726.807421625081;3731.067233191702;3732.533433320821;3740.401535754266;3307.024427793807;3311.3542859142476;3320.286138480214;3321.1033021084413;3325.451300535409;4508.368828364031;4510.436195475566;4518.502964673883;4525.5021947586065;4546.863594092182;4022.7586344819406;4224.4508213931995;4238.300680387732;4258.850110470186;4275.786210689453;4938.876528086791;4947.381577302837;4961.77672004757;4981.501849814989;4992.500749925015;3645.6354364563595;3649.4525821126776;3649.799261040642;3655.159313357916;3655.6161603031833;4984.626153038536;5161.406438259611;5169.638125331228;5170.6122040847085;5186.729251333448;3718.6467285607823;3732.0483276764253;3741.9438708419398;3743.6256374362893;3753;3796.544414670257;3809.980950095232;3818.866339678098;3826.125198652696;3835.2223060285596;4300.462442194726;4300.956990430056;4301.44081269433;4305.7416555006175;4307.870763877088;4744.644151688637;4911.9754401227765;4921.729304888266;4937.975310123426;4942.827001054946;1295.1322613848745;1307.9013628552061;1310.6303912411554;1313.2251971336957;1313.850380916698;856.9245596776007;863.8229163021565;902.5442151713343;916.7852595311106;919.3748251189122;4333.58830911063;4387.3857659927635;4415.3221775725015;4416.315471101984;4416.84541041062;5062.949370506321;5066;5081.822136225214;5110.131277682803;5129.64092513528;4248.299030659907;4355.041890784022;4359.433273674402;4365.519792822787;4392.956070439319;2676.4513274778624;2702.7567518923393;2719.360950176707;2720.891164353404;2722.033678044266;4722.716637001791;4760.238361862085;4761.809547613097;4769.594584460359;4780.521947805191;5000.399952005782;5100.322330776372;5154.896902061938;5182.896342073137;5201.141811601119;4711.74085425298;4746.1931471649905;4751.59611433032;4754.334393184957;4763.142634325785;5003.199488081889;5024.472430394756;5042.39491261051;5042.445076221328;5042.596592272536;4670.579647831712;4882.780274887567;4890.828820991391;4895.265710143507;4897.167481528078;4675.509071547439;4718.646101542329;4726.976365118152;4738.289256611536;4755.191617424977;3619.077135330474;3661.6521430464063;3663.523741913534;3668.192997540537;3668.376376016137;4862.978774457403;5027;5042.672226305279;5045.117104506623;5055.443901170795;4829.589484893683;4871.171900776805;4891.413030436228;4897.706137631753;4901.387326584177;4857.805687772591;4879.926801097916;4881.316615673737;4893.363862697826;4910.901781964412;4601.263797792337;4803.838272777194;4834.709917404967;4846.709197448165;4850.927236091532;4746.976265118652;4854.19905715553;4950.158473059517;4982.4768399317545;4982.526659967298;4862.489438608895;4889.975550122369;4907.950920490749;4911.754412279443;4916 10:44:11 INFO - PROCESS | 21650 | |5;yui.html;619.4301242856571;630.6310808177216;642.3383914567996;726.6802606852984;738.0737174845569;12337.568185113523;13015.544455944031;13261.403236854341;13297.069205155643;13321.666958326046;12095.032397408208;12818.423170957307;12819.102662813606;12857.742845143091;12864.163829351086;629.9590526615756;643.330935826742;643.6331291164039;781.7068599275286;792.8295416485455;645.725566634181;648.6464876642241;766.3294617209941;794.940379471539;800.1078797141175;824.756696774453;827.6772058897005;829.4608504472081;829.9211574900405;830.161536847782;828.7348048624442;829.4152622401193;829.6888666749969;829.7718127514952;830.0288662265104;482.8672115168322;577.777555641077;590.3918963467593;595.5622617376225;596.4333882811303;12255.816162757566;12270.693232669166;12274.263544187377;12284;12289.631311060682;11279.887201127965;11560.132990025782;11850.881491185064;11854.644360669108;12124.454399552042;10577.471126443725;10756.139508839275;10856.457177141112;10918.781624367468;11031.503582338813;4193.958060419387;4229.534751177368;4259.084296876155;4274.166537525184;4321.546237645065;57104.42895571074;57656;58970.70514647399;59382.99999999957;59766.70116649389;9454.669086581936;9607.51962401877;9661.275404344702;9673.854892176623;9738.123568878835;18078.548036298936;18092.095395230186;18112.818871811112;18176.1820718068;18187.54531136732;6337;6506.642134682544;6510.674466276667;6531.183602049744;6616.106825578581;3696.370953665662;3711.5917249102577;3728.217074414403;3740.9113062852657;3804.1630841214887;2466.728659847415;2529.3170843872053;2549.3754030262703;2550.7194208637034;2553.336132605536;489.0902920567741;505.507130547713;532.430299579454;533.7277988226033;536.2037374498866;498.4118739886968;504.78042051706893;567.5317862763237;603.7072020070262;604.9516038716893;7717.459777815611;7768.262015108556;7786.727464538714;7866.292033716879;7978;515.688008754698;518.6499113098644;519.6102922807894;536.342979849681;537.4276395638632;3419.829008549563;3462.4460086386057;3463.0995941055508;3485.4074807282823;3579.83890724918;93618.53190734138;98555.50722246486;104261.47869260605;104393.21444106109;105179;84916.57541712251;86269;87112.56443717868;87893;88527.11472885188;76325.23674763292;76671;77217.61391193008;77772.1387984991;78329;6585.967070164618;6676.132102826601;6807.489438292049;6826.044353790573;6888.621125838127;36138;45884.54115458803;45947.77026114848;46408.767956161355;46501.3024804635;58245;67273.3272667267;68682.3131768676;68694.31305686879;68759;9879.4072355656;9950.55222515003;9999.550020249251;10117;10532.104771094542;11283.435828208392;11418.942905285421;11460;11616.709582260512;12546.12177147591;10429.791404172025;10752.408617525798;10912.236143469881;11102.389368584805;11502.53989840397;11176.217664763388;11248.091584072157;11301.886981130083;11340.716482088013;11423.828642570203;10117;10274.126699230648;10391.896081039093;10677.412742299248;10732.678019659423;7857.724979625686;7918.3665306776475;8040.316573091352;8050.396220283385;8291.792705182419;8556.57217139128;8928.330375221754;8950.597223125105;9007.144321289728;9317 10:44:11 INFO - PROCESS | 21650 | __end_tp_report 10:44:11 INFO - PROCESS | 21650 | __start_cc_report 10:44:11 INFO - PROCESS | 21650 | _x_x_mozilla_cycle_collect,1061 10:44:11 INFO - PROCESS | 21650 | __end_cc_report 10:44:11 INFO - PROCESS | 21650 | __startTimestamp1465321451821__endTimestamp 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | ------- Summary: start ------- 10:44:11 INFO - PROCESS | 21650 | Number of tests: 6 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | [#0] dojo.html Cycles:165 Average:4605.66 Median:4746.29 stddev:472.85 (10.0%) stddev-sans-first:446.96 10:44:11 INFO - PROCESS | 21650 | Values: 2585.5 2624.5 2642.0 2657.4 2658.2 4508.1 4580.6 4648.4 4699.5 4752.6 4551.4 4612.5 4630.0 4635.6 4645.6 4274.9 4276.5 4289.8 4297.1 4315.5 4319.5 4360.0 4396.3 4413.3 4423.3 4326.1 4369.3 4375.5 4381.6 4406.9 4154.1 4185.4 4223.4 4223.7 4227.0 4203.8 4219.8 4263.0 4270.1 4314.7 4599.4 4608.3 4613.1 4614.7 4615.0 4833.1 4888.5 4944.2 4953.7 5015.6 5014.5 5018.1 5034.3 5043.2 5055.5 4551.7 4648.2 4653.9 4697.5 4705.5 4997.0 5069.2 5071.1 5086.5 5157.9 4899.4 4899.5 4941.4 4946.2 4960.7 4861.0 4861.4 4971.4 5020.4 5022.2 4817.6 4826.1 4850.3 4853.2 4897.5 4809.8 4815.1 4818.1 4819.4 4850.6 4105.5 4148.3 4154.0 4154.3 4193.3 3675.8 3676.4 3679.0 3711.4 3749.5 4339.9 4370.5 4373.4 4413.6 4422.9 4867.1 4945.1 4987.1 5040.2 5046.0 4356.1 4374.9 4380.0 4407.3 4419.7 4463.9 4497.2 4499.8 4514.1 4550.0 4617.9 4673.7 4719.2 4733.0 4734.6 5051.7 5057.1 5067.8 5070.0 5121.1 4743.5 4750.6 4756.5 4761.4 4807.1 4800.8 4854.5 4900.4 4926.6 4987.9 4980.8 5000.5 5003.0 5004.9 5034.1 4841.7 4868.6 4879.0 4879.8 4928.5 4746.3 4797.1 4840.4 4859.8 4880.0 4805.5 4810.2 4851.4 4857.5 4867.4 4759.3 4882.1 4889.3 4953.0 4960.2 4724.7 4725.3 4813.2 4821.3 4842.8 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | [#1] ext.html Cycles:180 Average:47415.28 Median:3431.84 stddev:83850.19 (2443.3%) stddev-sans-first:84011.55 10:44:11 INFO - PROCESS | 21650 | Values: 540.4 564.9 570.0 578.5 590.8 29777.6 41157.2 42148.4 42193.4 46234.1 37364.4 37616.0 37777.0 37797.2 37819.4 7455.5 7852.0 8022.0 8024.9 8027.4 7388.6 7661.4 7664.7 10125.1 10469.1 10390.1 10460.9 10464.0 10469.5 10470.9 10325.3 10370.6 10375.5 10377.9 10381.0 7534.4 7820.2 7820.3 9939.5 10384.7 38833.0 39393.8 39424.4 39466.8 39487.2 2770.6 2945.6 2958.6 3360.2 3467.2 29226.7 29469.9 30441.5 31253.0 31436.5 3308.4 3406.9 3428.2 3435.5 3435.7 245709.0 247635.0 248467.0 248582.0 249003.0 53750.7 54512.5 54513.5 54570.0 54686.0 57123.0 57293.4 57320.0 57596.0 57619.7 13778.2 14219.8 14226.6 14302.1 14321.4 9606.4 10757.1 10812.8 10823.1 10829.9 17350.8 17958.8 18006.6 18720.9 18763.0 6113.7 6202.8 6203.6 6246.3 6334.4 861.5 925.1 978.0 1007.9 1019.2 27408.0 28353.0 28756.0 30039.2 30542.4 963.7 1001.5 1032.4 1045.2 1063.9 14485.3 15172.0 15179.8 15392.9 15484.8 389198.0 389449.0 392500.0 392825.0 393950.0 50243.0 50348.0 50528.0 50533.5 50540.7 1080.5 1139.8 1180.5 1206.3 1246.4 27636.6 29124.4 29184.4 29267.7 29690.4 40510.0 40964.4 41015.6 41019.0 41137.6 298886.0 300804.0 301312.0 301348.0 301718.0 22613.0 25608.4 25617.0 25813.5 26320.0 42795.6 42836.6 43248.1 43607.6 43699.8 35026.5 35687.1 36064.6 36141.6 36434.0 35812.1 36265.0 36278.1 36519.3 36544.5 35880.8 36128.6 37357.3 38222.2 38363.0 31520.2 33632.3 33648.5 34042.0 34110.5 24750.5 25769.0 26127.3 26840.3 27212.6 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | [#2] jquery.html Cycles:180 Average:24608.68 Median:221665.67 stddev:64994.62 (29.3%) stddev-sans-first:65151.49 10:44:11 INFO - PROCESS | 21650 | Values: 378.3 382.4 383.0 393.9 393.9 15670.8 16809.0 17554.3 17680.6 17710.6 16111.8 16475.4 16597.8 16911.4 16922.3 4645.5 4781.5 4806.5 4815.6 4822.4 3548.6 3715.8 5187.5 5483.3 5484.7 5526.5 5528.4 5534.3 5557.3 5558.2 5842.7 6070.8 6186.3 6193.0 6194.4 5237.9 5419.0 5455.1 5493.6 5495.0 18824.3 19841.4 20426.4 20549.0 20629.5 1929.0 2333.8 2346.4 2422.9 2430.8 8821.1 8947.6 8963.4 8999.3 9343.5 1697.3 1736.8 1769.7 1800.0 1804.8 67864.0 69863.0 69893.0 71288.3 73200.3 10045.9 10117.8 10136.6 10291.3 10465.6 14089.6 14142.1 14200.5 14222.5 14229.1 6623.4 6649.0 6718.7 6747.2 6803.8 6453.4 6515.5 6617.9 6719.1 6729.5 4276.2 4296.7 4358.0 4389.3 4399.0 1580.1 1669.2 1790.3 1791.4 1803.8 830.8 858.1 865.0 866.8 890.3 16410.2 16533.7 16720.6 16890.3 17079.9 814.8 846.3 933.5 936.1 937.0 9051.8 9673.8 9702.8 9709.0 9824.8 311939.4 314770.0 431400.0 435404.0 438942.0 85727.6 88617.6 90505.9 92796.1 92870.0 913.9 924.5 958.3 961.0 974.2 15537.1 15584.2 15658.8 15795.6 16174.3 36874.1 37254.8 37294.6 37603.8 38418.0 49721.8 50880.2 52485.5 52747.0 53187.7 7539.4 7559.2 7600.4 7785.3 7983.6 8519.7 10807.7 11256.2 11964.5 12198.0 10080.6 10195.3 10380.2 10483.9 10572.0 10316.2 10370.6 10439.4 10491.3 10555.1 9571.7 10368.6 10449.6 10672.5 10762.7 7475.6 7637.6 7649.4 7654.8 7940.3 8085.6 9193.4 10428.2 10572.2 11147.3 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | [#3] mootools.html Cycles:180 Average:4935.89 Median:4580.36 stddev:2827.80 (61.7%) stddev-sans-first:2821.70 10:44:11 INFO - PROCESS | 21650 | Values: 1187.4 1355.7 1398.3 1506.3 1705.2 6649.1 7424.6 7699.7 7706.0 7868.6 7685.1 7706.4 7723.1 7767.2 7774.5 2214.3 2240.5 2243.3 2244.8 2245.4 2163.1 2194.1 2195.6 2196.4 2200.1 2209.7 2219.5 2229.3 2234.8 2245.4 2139.7 2157.7 2159.7 2174.1 2175.9 2096.4 2106.8 2109.3 2114.2 2114.2 7488.6 7596.8 7651.4 7658.2 7687.5 4404.4 4564.5 4571.1 4578.0 4582.3 2802.5 3033.8 3067.1 3081.5 3087.7 915.3 923.5 1017.4 1022.0 1053.4 10444.4 10447.7 10449.4 10452.4 10475.3 3946.6 4032.2 4246.4 4247.9 4249.0 8280.8 8361.8 8367.0 8396.2 8407.8 4486.4 4497.6 4501.7 4511.0 4514.4 3641.1 3656.5 4104.3 4107.1 4168.1 3405.4 3432.9 3496.6 3513.0 3618.5 983.2 983.7 992.1 993.9 1041.6 666.4 705.6 716.0 733.5 735.0 4465.7 4527.5 4578.4 4634.7 4782.4 397.3 407.8 409.9 414.6 421.7 3184.8 3253.8 3262.2 3273.8 3325.7 9130.8 9254.6 9597.9 9600.0 9634.0 9453.3 9521.2 9523.0 9527.8 9531.6 6955.8 6998.5 7104.1 7123.8 7137.9 4660.4 4683.8 4701.8 4732.1 4744.4 8844.1 8867.2 8883.3 8929.3 8955.8 8397.7 8652.7 8673.1 8682.1 8976.8 6588.4 6812.7 6930.6 6966.9 6982.3 7393.1 7410.7 7460.9 7468.9 7503.7 6378.1 6480.5 6533.5 6577.1 6612.1 6076.4 6090.0 6105.5 6169.8 6209.8 5780.7 5833.4 5854.2 5859.5 5870.7 3894.5 3945.9 4038.7 4154.5 4176.2 3888.7 3964.4 3999.7 4011.6 4038.8 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | [#4] prototype.html Cycles:180 Average:4114.59 Median:4705.37 stddev:1163.28 (24.7%) stddev-sans-first:1130.68 10:44:11 INFO - PROCESS | 21650 | Values: 295.6 297.8 298.8 306.4 312.3 4737.5 4741.5 4755.3 4755.4 4768.8 4647.5 4688.3 4699.0 4718.2 4728.6 3570.9 3644.9 3668.1 3764.9 3784.6 3744.4 3748.5 3752.6 3765.9 3774.8 3567.4 3721.9 3725.7 3730.6 3730.9 3609.9 3726.8 3731.1 3732.5 3740.4 3307.0 3311.4 3320.3 3321.1 3325.5 4508.4 4510.4 4518.5 4525.5 4546.9 4022.8 4224.5 4238.3 4258.9 4275.8 4938.9 4947.4 4961.8 4981.5 4992.5 3645.6 3649.5 3649.8 3655.2 3655.6 4984.6 5161.4 5169.6 5170.6 5186.7 3718.6 3732.0 3741.9 3743.6 3753.0 3796.5 3810.0 3818.9 3826.1 3835.2 4300.5 4301.0 4301.4 4305.7 4307.9 4744.6 4912.0 4921.7 4938.0 4942.8 1295.1 1307.9 1310.6 1313.2 1313.9 856.9 863.8 902.5 916.8 919.4 4333.6 4387.4 4415.3 4416.3 4416.8 5062.9 5066.0 5081.8 5110.1 5129.6 4248.3 4355.0 4359.4 4365.5 4393.0 2676.5 2702.8 2719.4 2720.9 2722.0 4722.7 4760.2 4761.8 4769.6 4780.5 5000.4 5100.3 5154.9 5182.9 5201.1 4711.7 4746.2 4751.6 4754.3 4763.1 5003.2 5024.5 5042.4 5042.4 5042.6 4670.6 4882.8 4890.8 4895.3 4897.2 4675.5 4718.6 4727.0 4738.3 4755.2 3619.1 3661.7 3663.5 3668.2 3668.4 4863.0 5027.0 5042.7 5045.1 5055.4 4829.6 4871.2 4891.4 4897.7 4901.4 4857.8 4879.9 4881.3 4893.4 4910.9 4601.3 4803.8 4834.7 4846.7 4850.9 4747.0 4854.2 4950.2 4982.5 4982.5 4862.5 4890.0 4908.0 4911.8 4916.0 10:44:11 INFO - PROCESS | 21650 | 10:44:11 INFO - PROCESS | 21650 | [#5] yui.html Cycles:180 Average:17646.00 Median:536.27 stddev:26160.82 (4878.3%) stddev-sans-first:26202.97 10:44:11 INFO - PROCESS | 21650 | Values: 619.4 630.6 642.3 726.7 738.1 12337.6 13015.5 13261.4 13297.1 13321.7 12095.0 12818.4 12819.1 12857.7 12864.2 630.0 643.3 643.6 781.7 792.8 645.7 648.6 766.3 794.9 800.1 824.8 827.7 829.5 829.9 830.2 828.7 829.4 829.7 829.8 830.0 482.9 577.8 590.4 595.6 596.4 12255.8 12270.7 12274.3 12284.0 12289.6 11279.9 11560.1 11850.9 11854.6 12124.5 10577.5 10756.1 10856.5 10918.8 11031.5 4194.0 4229.5 4259.1 4274.2 4321.5 57104.4 57656.0 58970.7 59383.0 59766.7 9454.7 9607.5 9661.3 9673.9 9738.1 18078.5 18092.1 18112.8 18176.2 18187.5 6337.0 6506.6 6510.7 6531.2 6616.1 3696.4 3711.6 3728.2 3740.9 3804.2 2466.7 2529.3 2549.4 2550.7 2553.3 489.1 505.5 532.4 533.7 536.2 498.4 504.8 567.5 603.7 605.0 7717.5 7768.3 7786.7 7866.3 7978.0 515.7 518.6 519.6 536.3 537.4 3419.8 3462.4 3463.1 3485.4 3579.8 93618.5 98555.5 104261.5 104393.2 105179.0 84916.6 86269.0 87112.6 87893.0 88527.1 76325.2 76671.0 77217.6 77772.1 78329.0 6586.0 6676.1 6807.5 6826.0 6888.6 36138.0 45884.5 45947.8 46408.8 46501.3 58245.0 67273.3 68682.3 68694.3 68759.0 9879.4 9950.6 9999.6 10117.0 10532.1 11283.4 11418.9 11460.0 11616.7 12546.1 10429.8 10752.4 10912.2 11102.4 11502.5 11176.2 11248.1 11301.9 11340.7 11423.8 10117.0 10274.1 10391.9 10677.4 10732.7 7857.7 7918.4 8040.3 8050.4 8291.8 8556.6 8928.3 8950.6 9007.1 9317.0 10:44:11 INFO - PROCESS | 21650 | -------- Summary: end -------- 10:44:11 INFO - PROCESS | 21650 | 10:44:12 INFO - TEST-INFO | 21650: exit 0 10:44:12 INFO - TEST-OK | dromaeo_css | took 1118537ms 10:44:12 INFO - TEST-START | kraken 10:44:12 INFO - operating with platform_type : linux_ 10:44:12 INFO - Initialising browser for kraken test... 10:44:12 INFO - TEST-INFO | started process 21826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPHgNQ/profile http://localhost:37266/getInfo.html) 10:44:16 INFO - PROCESS | 21826 | __metrics Screen width/height:1600/1200 10:44:16 INFO - PROCESS | 21826 | colorDepth:24 10:44:16 INFO - PROCESS | 21826 | Browser inner width/height: 1024/697 10:44:16 INFO - PROCESS | 21826 | __metrics 10:44:17 ERROR - PROCESS | 21826 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:44:17 INFO - PROCESS | 21826 | console.error: PushService: 10:44:17 INFO - PROCESS | 21826 | stateChangeProcessEnqueue: Error transitioning state 10:44:17 INFO - PROCESS | 21826 | UnknownError 10:44:18 INFO - TEST-INFO | 21826: exit 0 10:44:18 INFO - Browser initialized. 10:44:18 INFO - Running cycle 1/1 for kraken test... 10:44:18 INFO - TEST-INFO | started process 21907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPHgNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:44:30 INFO - PROCESS | 21907 | RSS: Main: 157409280 10:44:30 INFO - PROCESS | 21907 | 10:44:33 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-beat-detection) 10:44:34 INFO - PROCESS | 21907 | RSS: Main: 214622208 10:44:34 INFO - PROCESS | 21907 | 10:44:37 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-dft) 10:44:37 INFO - PROCESS | 21907 | RSS: Main: 200794112 10:44:37 INFO - PROCESS | 21907 | 10:44:41 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-fft) 10:44:41 INFO - PROCESS | 21907 | RSS: Main: 270708736 10:44:41 INFO - PROCESS | 21907 | 10:44:43 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37266/tests/kraken/driver.html?testName=audio-oscillator) 10:44:44 INFO - PROCESS | 21907 | RSS: Main: 180535296 10:44:44 INFO - PROCESS | 21907 | 10:44:46 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:44:47 INFO - PROCESS | 21907 | RSS: Main: 184078336 10:44:47 INFO - PROCESS | 21907 | 10:44:50 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37266/tests/kraken/driver.html?testName=imaging-darkroom) 10:44:51 INFO - PROCESS | 21907 | RSS: Main: 220524544 10:44:51 INFO - PROCESS | 21907 | 10:44:54 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37266/tests/kraken/driver.html?testName=imaging-desaturate) 10:44:55 INFO - PROCESS | 21907 | RSS: Main: 216768512 10:44:55 INFO - PROCESS | 21907 | 10:44:58 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37266/tests/kraken/driver.html?testName=json-parse-financial) 10:44:58 INFO - PROCESS | 21907 | RSS: Main: 219312128 10:44:58 INFO - PROCESS | 21907 | 10:45:00 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:45:01 INFO - PROCESS | 21907 | RSS: Main: 207884288 10:45:01 INFO - PROCESS | 21907 | 10:45:02 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:45:03 INFO - PROCESS | 21907 | RSS: Main: 210427904 10:45:03 INFO - PROCESS | 21907 | 10:45:05 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:45:06 INFO - PROCESS | 21907 | RSS: Main: 215973888 10:45:06 INFO - PROCESS | 21907 | 10:45:09 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:45:09 INFO - PROCESS | 21907 | RSS: Main: 222781440 10:45:09 INFO - PROCESS | 21907 | 10:45:12 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:45:13 INFO - PROCESS | 21907 | RSS: Main: 223338496 10:45:13 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | Cycle 1(1): loaded http://localhost:37266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37266/tests/kraken/driver.html?testName=ai-astar) 10:45:15 INFO - PROCESS | 21907 | RSS: Main: 265662464 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | __start_tp_report 10:45:15 INFO - PROCESS | 21907 | _x_x_mozilla_page_load 10:45:15 INFO - PROCESS | 21907 | _x_x_mozilla_page_load_details 10:45:15 INFO - PROCESS | 21907 | |i|pagename|runs| 10:45:15 INFO - PROCESS | 21907 | |0;ai-astar;113;110;115;114;119;115;114;115;115;116 10:45:15 INFO - PROCESS | 21907 | |1;audio-beat-detection;160;137;132;190;129;148;151;135;185;130 10:45:15 INFO - PROCESS | 21907 | |2;audio-dft;162;162;161;162;162;163;163;161;161;162 10:45:15 INFO - PROCESS | 21907 | |3;audio-fft;74;75;75;120;75;76;75;76;107;75 10:45:15 INFO - PROCESS | 21907 | |4;audio-oscillator;86;86;115;86;87;87;113;86;86;124 10:45:15 INFO - PROCESS | 21907 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 10:45:15 INFO - PROCESS | 21907 | |6;imaging-darkroom;148;147;147;146;146;145;147;145;146;145 10:45:15 INFO - PROCESS | 21907 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;94 10:45:15 INFO - PROCESS | 21907 | |8;json-parse-financial;65;65;65;65;65;64;66;66;72;65 10:45:15 INFO - PROCESS | 21907 | |9;json-stringify-tinderbox;65;65;66;64;64;66;65;67;66;65 10:45:15 INFO - PROCESS | 21907 | |10;stanford-crypto-aes;84;84;83;83;83;94;90;93;119;84 10:45:15 INFO - PROCESS | 21907 | |11;stanford-crypto-ccm;142;134;140;131;130;130;129;140;147;132 10:45:15 INFO - PROCESS | 21907 | |12;stanford-crypto-pbkdf2;171;171;168;169;168;168;171;171;168;170 10:45:15 INFO - PROCESS | 21907 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;68;69;72;66;66 10:45:15 INFO - PROCESS | 21907 | __end_tp_report 10:45:15 INFO - PROCESS | 21907 | __start_cc_report 10:45:15 INFO - PROCESS | 21907 | _x_x_mozilla_cycle_collect,1878 10:45:15 INFO - PROCESS | 21907 | __end_cc_report 10:45:15 INFO - PROCESS | 21907 | __startTimestamp1465321515326__endTimestamp 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | ------- Summary: start ------- 10:45:15 INFO - PROCESS | 21907 | Number of tests: 14 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:2.27 (2.0%) stddev-sans-first:2.33 10:45:15 INFO - PROCESS | 21907 | Values: 113.0 110.0 115.0 114.0 119.0 115.0 114.0 115.0 115.0 116.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:149.50 stddev:22.33 (14.9%) stddev-sans-first:23.37 10:45:15 INFO - PROCESS | 21907 | Values: 160.0 137.0 132.0 190.0 129.0 148.0 151.0 135.0 185.0 130.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:45:15 INFO - PROCESS | 21907 | Values: 162.0 162.0 161.0 162.0 162.0 163.0 163.0 161.0 161.0 162.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:16.48 (22.0%) stddev-sans-first:17.17 10:45:15 INFO - PROCESS | 21907 | Values: 74.0 75.0 75.0 120.0 75.0 76.0 75.0 76.0 107.0 75.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:86.00 stddev:15.25 (17.7%) stddev-sans-first:15.78 10:45:15 INFO - PROCESS | 21907 | Values: 86.0 86.0 115.0 86.0 87.0 87.0 113.0 86.0 86.0 124.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:45:15 INFO - PROCESS | 21907 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:1.03 (0.7%) stddev-sans-first:0.87 10:45:15 INFO - PROCESS | 21907 | Values: 148.0 147.0 147.0 146.0 146.0 145.0 147.0 145.0 146.0 145.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:45:15 INFO - PROCESS | 21907 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:65.00 stddev:2.25 (3.5%) stddev-sans-first:2.37 10:45:15 INFO - PROCESS | 21907 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 66.0 66.0 72.0 65.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 10:45:15 INFO - PROCESS | 21907 | Values: 65.0 65.0 66.0 64.0 64.0 66.0 65.0 67.0 66.0 65.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:84.00 stddev:11.16 (13.3%) stddev-sans-first:11.64 10:45:15 INFO - PROCESS | 21907 | Values: 84.0 84.0 83.0 83.0 83.0 94.0 90.0 93.0 119.0 84.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:137.00 stddev:6.26 (4.6%) stddev-sans-first:6.18 10:45:15 INFO - PROCESS | 21907 | Values: 142.0 134.0 140.0 131.0 130.0 130.0 129.0 140.0 147.0 132.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.50 stddev:1.43 (0.8%) stddev-sans-first:1.41 10:45:15 INFO - PROCESS | 21907 | Values: 171.0 171.0 168.0 169.0 168.0 168.0 171.0 171.0 168.0 170.0 10:45:15 INFO - PROCESS | 21907 | 10:45:15 INFO - PROCESS | 21907 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.73 (2.5%) stddev-sans-first:1.80 10:45:15 INFO - PROCESS | 21907 | Values: 67.0 68.0 68.0 68.0 67.0 68.0 69.0 72.0 66.0 66.0 10:45:15 INFO - PROCESS | 21907 | -------- Summary: end -------- 10:45:15 INFO - PROCESS | 21907 | 10:45:16 INFO - TEST-INFO | 21907: exit 0 10:45:16 INFO - TEST-OK | kraken | took 63802ms 10:45:16 INFO - SUITE-END | took 1182s 10:45:16 INFO - Completed test suite (00:19:42) 10:45:16 INFO - javascript benchmark 10:45:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.508753336866, 2624.4882247961655, 2642.048862409533, 2657.3755167535624, 2658.215826331232, 4508.053308805147, 4580.58774710276, 4648.395708557887, 4699.483056863746, 4752.643551733621, 4551.385562949001, 4612.492625811158, 4630.0, 4635.605973492257, 4645.605123564501, 4274.893127671802, 4276.50820155683, 4289.785510724467, 4297.140571885635, 4315.546867578906, 4319.524852266248, 4359.956400436003, 4396.296592545194, 4413.3159360299205, 4423.336499525081, 4326.134773045404, 4369.257226271526, 4375.540568240337, 4381.649468042581, 4406.889827754299, 4154.065335299563, 4185.351270553069, 4223.408722778813, 4223.66210703143, 4226.957730422687, 4203.810828512725, 4219.831206751726, 4263.040815816447, 4270.081932384553, 4314.741115533078, 4599.356090147382, 4608.33179189019, 4613.077384523109, 4614.72311661298, 4615.0, 4833.10587541306, 4888.486708895551, 4944.233643785219, 4953.653244272902, 5015.648904576681, 5014.548690617862, 5018.146915024455, 5034.270030845543, 5043.167877300241, 5055.51972562606, 4551.749653769009, 4648.1865673507, 4653.86038418848, 4697.506761790031, 4705.458872229703, 4996.975015124901, 5069.239614057921, 5071.087204303187, 5086.516780905808, 5157.896842063138, 4899.363082799285, 4899.510048995143, 4941.407031156285, 4946.233333833262, 4960.70235785854, 4860.95139048605, 4861.368022157097, 4971.428285747185, 5020.422651395063, 5022.246663000579, 4817.590504807061, 4826.0589185108565, 4850.345203397566, 4853.223484242504, 4897.4857639947295, 4809.78355973982, 4815.133276010351, 4818.10864989978, 4819.421669399624, 4850.587700045465, 4105.548389677133, 4148.274052040881, 4153.958460415418, 4154.335306350969, 4193.30810416284, 3675.7978311192605, 3676.356637588411, 3679.0434487033563, 3711.350513660099, 3749.531308586427, 4339.934900976488, 4370.497392799805, 4373.409589705413, 4413.558644135625, 4422.867313980586, 4867.050925069578, 4945.134601444733, 4987.0524600325825, 5040.218766091261, 5045.9747701261995, 4356.106998065389, 4374.934375984363, 4379.956200438019, 4407.27279998803, 4419.668524860648, 4463.866084017484, 4497.190505708938, 4499.842505512292, 4514.052049069666, 4550.0217453247715, 4617.930731039037, 4673.719576825401, 4719.197736384823, 4732.982408782128, 4734.55021772931, 5051.747412629427, 5057.064443078042, 5067.847964561069, 5069.9746501267255, 5121.129408000724, 4743.549362810528, 4750.596199323097, 4756.453007904135, 4761.362454755608, 4807.134715751198, 4800.7599620019555, 4854.538818812207, 4900.411950565955, 4926.556609905126, 4987.9002419950675, 4980.825671101494, 5000.499950004971, 5003.049420610072, 5004.949950500449, 5034.119029169954, 4841.733704646278, 4868.561829435368, 4879.024195160911, 4879.780409881493, 4928.507149285043, 4746.288056791509, 4797.064572408486, 4840.443349014909, 4859.829905953275, 4879.975600121977, 4805.495422980537, 4810.182269014346, 4851.417829860439, 4857.53853383928, 4867.415910090812, 4759.309900064402, 4882.145624515767, 4889.266610008527, 4953.0, 4960.156773348467, 4724.71651700899, 4725.314829349656, 4813.181759100891, 4821.325014498043, 4842.7820748065715], "value": 4576.091344343541, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.3911982729959, 564.875727339985, 569.9886002279957, 578.482258378751, 590.7636945221909, 29777.55333669994, 41157.17685646285, 42148.367774483406, 42193.36709949353, 46234.07531849361, 37364.439533406956, 37616.0, 37777.0, 37797.244055118885, 37819.4327085094, 7455.4781165318445, 7851.960740196291, 8022.0, 8024.919750802475, 8027.397945154107, 7388.556686598795, 7661.387089032892, 7664.731734389297, 10125.088742013217, 10469.11012563933, 10390.064894159525, 10460.895391046106, 10464.0, 10469.4765261737, 10470.895291047107, 10325.277230593823, 10370.63702770407, 10375.481225938673, 10377.948110259438, 10381.0, 7534.434917381218, 7820.178881217447, 7820.335271501929, 9939.453330066843, 10384.688459346156, 38833.0, 39393.80303098466, 39424.40863387052, 39466.802665986484, 39487.21025579472, 2770.598263251817, 2945.5581662750546, 2958.6153800005864, 3360.2029706431576, 3467.2025434150287, 29226.707732922612, 29469.852650736608, 30441.543376849364, 31253.0, 31436.52845207324, 3308.354870800195, 3406.9488957665653, 3428.160100775301, 3435.519027336175, 3435.656434356569, 245709.0, 247635.0, 248467.0, 248582.0, 249003.0, 53750.731246343516, 54512.454875451534, 54513.45486545084, 54570.0, 54686.0, 57123.0, 57293.427065729644, 57320.0, 57596.0, 57619.71190144023, 13778.173309601456, 14219.786703199461, 14226.644333891736, 14302.140721706319, 14321.427142914376, 9606.375585586915, 10757.085647719874, 10812.837807432894, 10823.134149268197, 10829.945850270698, 17350.826491734922, 17958.820411795714, 18006.639867202844, 18720.90639546821, 18763.0, 6113.663748493876, 6202.813915582449, 6203.627782333075, 6246.3441338659695, 6334.429901308904, 861.5347712235323, 925.0656836595087, 977.9559919803626, 1007.9445630490246, 1019.23557332001, 27408.0, 28353.0, 28756.0, 30039.24901877427, 30542.38915221683, 963.6819849449805, 1001.4792307999945, 1032.3547782635853, 1045.231754660324, 1063.9202059845543, 14485.348159332856, 15172.0, 15179.772303415457, 15392.92303538475, 15484.767728484081, 389198.0, 389449.0, 392500.0, 392825.0, 393950.0, 50243.0, 50348.0, 50528.0, 50533.494665053615, 50540.74729626328, 1080.4651697409674, 1139.834723965037, 1180.492388273051, 1206.3244583033354, 1246.4328730427815, 27636.585451217845, 29124.35731056161, 29184.416311673223, 29267.707322926497, 29690.406191876475, 40510.0, 40964.38553421642, 41015.589844101174, 41019.0, 41137.58862411338, 298886.0, 300804.0, 301312.0, 301348.0, 301718.0, 22613.0, 25608.359791005372, 25617.0, 25813.483730325665, 26320.0, 42795.57204427916, 42836.57163428326, 43248.135037299704, 43607.56392436162, 43699.78150109229, 35026.474602880466, 35687.10782230361, 36064.63935360613, 36141.63858361383, 36433.99613021309, 35812.104697382776, 36265.0, 36278.09304767402, 36519.26961460809, 36544.45183322199, 35880.820595896854, 36128.63871361358, 37357.25285494329, 38222.23555528929, 38363.0, 31520.211994700316, 33632.327353453285, 33648.49527257142, 34042.0, 34110.48834267438, 24750.504989899742, 25769.0, 26127.346816329744, 26840.32899177536, 27212.591811122453], "value": 17985.179194420267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2769484995845, 382.426360459311, 382.9999999999999, 393.877897851666, 393.9133390654055, 15670.84329156708, 16809.0, 17554.297828086877, 17680.64638707225, 17710.645787084268, 16111.83888161118, 16475.423360182394, 16597.751033734505, 16911.40810071648, 16922.323107075703, 4645.465771436286, 4781.521847815226, 4806.519348065183, 4815.5906747926465, 4822.397200349957, 3548.574171099459, 3715.7584756990846, 5187.455317191679, 5483.259759932398, 5484.725763711818, 5526.530244929186, 5528.364238112608, 5534.335879694442, 5557.277553917985, 5558.194061861028, 5842.707864606753, 6070.817875463699, 6186.288576813679, 6193.0, 6194.380561943814, 5237.921431178535, 5419.0, 5455.099908515091, 5493.615446918718, 5495.0, 18824.341148059888, 19841.404757857286, 20426.38720838377, 20549.0, 20629.4842628934, 1929.0, 2333.8249631277554, 2346.389938615955, 2422.92731218062, 2430.8419952703016, 8821.07378725231, 8947.597358118901, 8963.372563920528, 8999.280057595442, 9343.532823358804, 1697.3210715713813, 1736.8263173682658, 1769.7256925176619, 1800.0459756329035, 1804.8014718380969, 67864.0, 69863.0, 69893.0, 71288.2871171292, 73200.26799731988, 10045.899541004643, 10117.797644047225, 10136.594536218468, 10291.279610427198, 10465.633702820516, 14089.647758806112, 14142.080764750259, 14200.502982395567, 14222.502212422516, 14229.14625122496, 6623.370779775913, 6649.0, 6718.697658605374, 6747.156605424322, 6803.7618683345845, 6453.386928241809, 6515.4787616990525, 6617.867642647217, 6719.0593316935665, 6729.528932974645, 4276.2302785498905, 4296.742195468282, 4358.019445624709, 4389.341598760211, 4398.978005110018, 1580.138824340737, 1669.2238109279, 1790.2838864454322, 1791.3551121596215, 1803.765510483655, 830.8379865926207, 858.1418581418582, 864.9654013839375, 866.787637028932, 890.2922176869405, 16410.1794910254, 16533.6693266134, 16720.58198545022, 16890.324387024382, 17079.914600426917, 814.8288859339486, 846.2806614377853, 933.4772527384687, 936.0826390137703, 936.9812603747887, 9051.773705657279, 9673.806523869624, 9702.805943881083, 9709.0, 9824.754381140387, 311939.44030280155, 314770.0, 431400.0, 435404.0, 438942.0, 85727.57136214279, 88617.55691221502, 90505.94940505897, 92796.07203928009, 92870.0, 913.8857642794651, 924.4961495984704, 958.3291695812959, 960.9711708648751, 974.201155052864, 15537.145456999973, 15584.220788960733, 15658.843411566195, 15795.605109871885, 16174.272157752694, 36874.078148046516, 37254.8137259312, 37294.62705372911, 37603.81198093992, 38418.0, 49721.75139124281, 50880.236796447345, 52485.475145248056, 52747.0, 53187.734061329444, 7539.359154471931, 7559.203980099503, 7600.391968642606, 7785.299323060725, 7983.600819959095, 8519.701810436605, 10807.67576972692, 11256.155788316073, 11964.521419143137, 12198.0, 10080.596776128872, 10195.286329957129, 10380.221483388625, 10483.895161048293, 10572.048515633629, 10316.226283028953, 10370.585176592851, 10439.37363758177, 10491.265611407434, 10555.102816260704, 9571.712848614552, 10368.585256589651, 10449.582016719247, 10672.519736611715, 10762.677119686421, 7475.551466912003, 7637.618119094134, 7649.388048955959, 7654.808629784077, 7940.28537431634, 8085.555294458862, 9193.448393096436, 10428.165746740395, 10572.154227661922, 11147.331160130418], "value": 8252.916406067443, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.4181650991006, 1355.6610847288177, 1398.3148257353894, 1506.337211626884, 1705.2326453096102, 6649.069130321753, 7424.591647459394, 7699.730509432171, 7705.961470192641, 7868.606569671522, 7685.116211635664, 7706.383489320855, 7723.111842138156, 7767.223277672244, 7774.494657847236, 2214.291426743439, 2240.451089483071, 2243.25972429098, 2244.80919121874, 2245.4274160089235, 2163.102312540294, 2194.0565556810566, 2195.6157672407344, 2196.3850121965875, 2200.108955872874, 2209.723784526934, 2219.4673278413225, 2229.2754854672216, 2234.821214302852, 2245.4161917901383, 2139.711138996231, 2157.6655618379177, 2159.7084393606897, 2174.065151984646, 2175.869447833127, 2096.423483542023, 2106.799854013866, 2109.3039297032096, 2114.1754715660904, 2114.196605289995, 7488.625568721596, 7596.848063038764, 7651.387888968869, 7658.157602663702, 7687.461877668566, 4404.427424434803, 4564.520725323827, 4571.108633816407, 4577.9542204577865, 4582.289745089483, 2802.467531169071, 3033.7572994160414, 3067.1105379439937, 3081.4607443697264, 3087.72210501056, 915.3043686798015, 923.4643906534261, 1017.3539802225566, 1021.9948900255451, 1053.425882893817, 10444.373337599693, 10447.68656940293, 10449.373037617766, 10452.425116618508, 10475.319104258198, 3946.565877753445, 4032.213718324957, 4246.363045543131, 4247.851325203603, 4248.978755106266, 8280.792980175544, 8361.83276334482, 8366.958165209135, 8396.160383961555, 8407.789805254917, 4486.439195100613, 4497.617702495259, 4501.6848820582245, 4510.977445112753, 4514.413126293561, 3641.0715267606593, 3656.4880916671686, 4104.343305071175, 4107.075907920694, 4168.145530166309, 3405.3870303345634, 3432.9313413731584, 3496.615372309044, 3512.964870351315, 3618.493410922473, 983.1692220074026, 983.6557204978201, 992.0773680477225, 993.8509223616371, 1041.5521325829966, 666.4435196610884, 705.5837056136904, 715.9534630249017, 733.4792297468857, 734.9559026458429, 4465.709728867613, 4527.456705195397, 4578.427696537933, 4634.652401069866, 4782.426108866958, 397.3443817700759, 407.83482689510794, 409.87293938878446, 414.64340667026335, 421.7427369304722, 3184.824834634071, 3253.788503747296, 3262.168147122469, 3273.7544684148306, 3325.73394128474, 9130.771730706652, 9254.583543740548, 9597.90402095984, 9600.0, 9634.0, 9453.291003174789, 9521.19069879068, 9523.047695230422, 9527.761805954906, 9531.571079301448, 6955.791326260221, 6998.4751143664425, 7104.147502299654, 7123.821904452327, 7137.85724285501, 4660.370849935215, 4683.765811709469, 4701.764911754331, 4732.100900828831, 4744.359511465908, 8844.115588441362, 8867.157620026088, 8883.289336852908, 8929.285657147282, 8955.820883582162, 8397.748067557983, 8652.740417787476, 8673.089325620718, 8682.088380719933, 8976.775580610538, 6588.40704336612, 6812.659367031728, 6930.584164950119, 6966.895496567454, 6982.266861979419, 7393.07586551681, 7410.703571857281, 7460.925390746023, 7468.887966680612, 7503.737369192052, 6378.138951241523, 6480.546361754632, 6533.477321814148, 6577.14497115372, 6612.140421745143, 6076.392360763888, 6090.0, 6105.511559075352, 6169.753209871555, 6209.813705588839, 5780.7398667060925, 5833.387494313036, 5854.2389489366105, 5859.472647461749, 5870.677112758668, 3894.4937158169255, 3945.861894833667, 4038.7374820636564, 4154.522229943595, 4176.248275310473, 3888.650021498079, 3964.385520244367, 3999.680025597887, 4011.5959414204794, 4038.757674539537], "value": 3896.386297475049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.62308057227034, 297.8034497231827, 298.82817380006503, 306.3688801069796, 312.3300520383777, 4737.531365276766, 4741.525847415257, 4755.3104799804005, 4755.429348478183, 4768.760122368183, 4647.53524647536, 4688.343631891529, 4699.0, 4718.245080787075, 4728.645351598627, 3570.9107272318142, 3644.8906532803926, 3668.137987572918, 3764.9435258471144, 3784.6026167252453, 3744.3634582121103, 3748.475213470116, 3752.587215406303, 3765.8722821605706, 3774.792386418746, 3567.3935430976667, 3721.869734559291, 3725.7019438444995, 3730.608286129958, 3730.9067273318115, 3609.9097522561883, 3726.807421625081, 3731.067233191702, 3732.533433320821, 3740.401535754266, 3307.024427793807, 3311.3542859142476, 3320.286138480214, 3321.1033021084413, 3325.451300535409, 4508.368828364031, 4510.436195475566, 4518.502964673883, 4525.5021947586065, 4546.863594092182, 4022.7586344819406, 4224.4508213931995, 4238.300680387732, 4258.850110470186, 4275.786210689453, 4938.876528086791, 4947.381577302837, 4961.77672004757, 4981.501849814989, 4992.500749925015, 3645.6354364563595, 3649.4525821126776, 3649.799261040642, 3655.159313357916, 3655.6161603031833, 4984.626153038536, 5161.406438259611, 5169.638125331228, 5170.6122040847085, 5186.729251333448, 3718.6467285607823, 3732.0483276764253, 3741.9438708419398, 3743.6256374362893, 3753.0, 3796.544414670257, 3809.980950095232, 3818.866339678098, 3826.125198652696, 3835.2223060285596, 4300.462442194726, 4300.956990430056, 4301.44081269433, 4305.7416555006175, 4307.870763877088, 4744.644151688637, 4911.9754401227765, 4921.729304888266, 4937.975310123426, 4942.827001054946, 1295.1322613848745, 1307.9013628552061, 1310.6303912411554, 1313.2251971336957, 1313.850380916698, 856.9245596776007, 863.8229163021565, 902.5442151713343, 916.7852595311106, 919.3748251189122, 4333.58830911063, 4387.3857659927635, 4415.3221775725015, 4416.315471101984, 4416.84541041062, 5062.949370506321, 5066.0, 5081.822136225214, 5110.131277682803, 5129.64092513528, 4248.299030659907, 4355.041890784022, 4359.433273674402, 4365.519792822787, 4392.956070439319, 2676.4513274778624, 2702.7567518923393, 2719.360950176707, 2720.891164353404, 2722.033678044266, 4722.716637001791, 4760.238361862085, 4761.809547613097, 4769.594584460359, 4780.521947805191, 5000.399952005782, 5100.322330776372, 5154.896902061938, 5182.896342073137, 5201.141811601119, 4711.74085425298, 4746.1931471649905, 4751.59611433032, 4754.334393184957, 4763.142634325785, 5003.199488081889, 5024.472430394756, 5042.39491261051, 5042.445076221328, 5042.596592272536, 4670.579647831712, 4882.780274887567, 4890.828820991391, 4895.265710143507, 4897.167481528078, 4675.509071547439, 4718.646101542329, 4726.976365118152, 4738.289256611536, 4755.191617424977, 3619.077135330474, 3661.6521430464063, 3663.523741913534, 3668.192997540537, 3668.376376016137, 4862.978774457403, 5027.0, 5042.672226305279, 5045.117104506623, 5055.443901170795, 4829.589484893683, 4871.171900776805, 4891.413030436228, 4897.706137631753, 4901.387326584177, 4857.805687772591, 4879.926801097916, 4881.316615673737, 4893.363862697826, 4910.901781964412, 4601.263797792337, 4803.838272777194, 4834.709917404967, 4846.709197448165, 4850.927236091532, 4746.976265118652, 4854.19905715553, 4950.158473059517, 4982.4768399317545, 4982.526659967298, 4862.489438608895, 4889.975550122369, 4907.950920490749, 4911.754412279443, 4916.0], "value": 3750.5251654485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4301242856571, 630.6310808177216, 642.3383914567996, 726.6802606852984, 738.0737174845569, 12337.568185113523, 13015.544455944031, 13261.403236854341, 13297.069205155643, 13321.666958326046, 12095.032397408208, 12818.423170957307, 12819.102662813606, 12857.742845143091, 12864.163829351086, 629.9590526615756, 643.330935826742, 643.6331291164039, 781.7068599275286, 792.8295416485455, 645.725566634181, 648.6464876642241, 766.3294617209941, 794.940379471539, 800.1078797141175, 824.756696774453, 827.6772058897005, 829.4608504472081, 829.9211574900405, 830.161536847782, 828.7348048624442, 829.4152622401193, 829.6888666749969, 829.7718127514952, 830.0288662265104, 482.8672115168322, 577.777555641077, 590.3918963467593, 595.5622617376225, 596.4333882811303, 12255.816162757566, 12270.693232669166, 12274.263544187377, 12284.0, 12289.631311060682, 11279.887201127965, 11560.132990025782, 11850.881491185064, 11854.644360669108, 12124.454399552042, 10577.471126443725, 10756.139508839275, 10856.457177141112, 10918.781624367468, 11031.503582338813, 4193.958060419387, 4229.534751177368, 4259.084296876155, 4274.166537525184, 4321.546237645065, 57104.42895571074, 57656.0, 58970.70514647399, 59382.99999999957, 59766.70116649389, 9454.669086581936, 9607.51962401877, 9661.275404344702, 9673.854892176623, 9738.123568878835, 18078.548036298936, 18092.095395230186, 18112.818871811112, 18176.1820718068, 18187.54531136732, 6337.0, 6506.642134682544, 6510.674466276667, 6531.183602049744, 6616.106825578581, 3696.370953665662, 3711.5917249102577, 3728.217074414403, 3740.9113062852657, 3804.1630841214887, 2466.728659847415, 2529.3170843872053, 2549.3754030262703, 2550.7194208637034, 2553.336132605536, 489.0902920567741, 505.507130547713, 532.430299579454, 533.7277988226033, 536.2037374498866, 498.4118739886968, 504.78042051706893, 567.5317862763237, 603.7072020070262, 604.9516038716893, 7717.459777815611, 7768.262015108556, 7786.727464538714, 7866.292033716879, 7978.0, 515.688008754698, 518.6499113098644, 519.6102922807894, 536.342979849681, 537.4276395638632, 3419.829008549563, 3462.4460086386057, 3463.0995941055508, 3485.4074807282823, 3579.83890724918, 93618.53190734138, 98555.50722246486, 104261.47869260605, 104393.21444106109, 105179.0, 84916.57541712251, 86269.0, 87112.56443717868, 87893.0, 88527.11472885188, 76325.23674763292, 76671.0, 77217.61391193008, 77772.1387984991, 78329.0, 6585.967070164618, 6676.132102826601, 6807.489438292049, 6826.044353790573, 6888.621125838127, 36138.0, 45884.54115458803, 45947.77026114848, 46408.767956161355, 46501.3024804635, 58245.0, 67273.3272667267, 68682.3131768676, 68694.31305686879, 68759.0, 9879.4072355656, 9950.55222515003, 9999.550020249251, 10117.0, 10532.104771094542, 11283.435828208392, 11418.942905285421, 11460.0, 11616.709582260512, 12546.12177147591, 10429.791404172025, 10752.408617525798, 10912.236143469881, 11102.389368584805, 11502.53989840397, 11176.217664763388, 11248.091584072157, 11301.886981130083, 11340.716482088013, 11423.828642570203, 10117.0, 10274.126699230648, 10391.896081039093, 10677.412742299248, 10732.678019659423, 7857.724979625686, 7918.3665306776475, 8040.316573091352, 8050.396220283385, 8291.792705182419, 8556.57217139128, 8928.330375221754, 8950.597223125105, 9007.144321289728, 9317.0], "value": 6291.3044263287575, "unit": "score"}], "name": "dromaeo_css", "value": 6298.846015062769, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 115.0, 114.0, 119.0, 115.0, 114.0, 115.0, 115.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 137.0, 132.0, 190.0, 129.0, 148.0, 151.0, 135.0, 185.0, 130.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 163.0, 161.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 120.0, 75.0, 76.0, 75.0, 76.0, 107.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 115.0, 86.0, 87.0, 87.0, 113.0, 86.0, 86.0, 124.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0, 72.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 64.0, 66.0, 65.0, 67.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 83.0, 94.0, 90.0, 93.0, 119.0, 84.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 140.0, 131.0, 130.0, 130.0, 129.0, 140.0, 147.0, 132.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 168.0, 169.0, 168.0, 168.0, 171.0, 171.0, 168.0, 170.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 69.0, 72.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1556.1999999999998, "alertThreshold": 2.0}]} 10:45:16 INFO - Return code: 0 10:45:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:45:16 ERROR - # TBPL SUCCESS # 10:45:16 INFO - Running post-action listener: _resource_record_post_action 10:45:16 INFO - ##### 10:45:16 INFO - ##### Finished run-tests step (success) 10:45:16 INFO - ##### 10:45:16 INFO - Running post-run listener: _resource_record_post_run 10:45:16 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 524091392; Read time: 0; Write time: 446780 10:45:16 INFO - TinderboxPrint: CPU usage
13.1% 10:45:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:45:16 INFO - TinderboxPrint: I/O write bytes / time
524,091,392 / 446,780 10:45:16 INFO - TinderboxPrint: CPU idle
8,313.2 (86.9%) 10:45:16 INFO - TinderboxPrint: CPU user
1,212.8 (12.7%) 10:45:16 INFO - TinderboxPrint: Swap in / out
0 / 0 10:45:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237187072; Read time: 0; Write time: 233424 10:45:16 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 286232576; Read time: 0; Write time: 213356 10:45:17 INFO - Running post-run listener: _upload_blobber_files 10:45:17 INFO - Blob upload gear active. 10:45:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:45:17 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 10:45:17 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:45:17 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:45:17 INFO - (blobuploader) - INFO - Open directory for files ... 10:45:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:45:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:18 INFO - (blobuploader) - INFO - Done attempting. 10:45:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:45:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:45:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:22 INFO - (blobuploader) - INFO - Done attempting. 10:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:45:23 INFO - (blobuploader) - INFO - Done attempting. 10:45:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:45:23 INFO - Return code: 0 10:45:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:45:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:45:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1d49eebcb839341c2738a605fc08a066e2e8b545bdc8d8977b260363749a7a56bb3bb83db990211a3c636b209a4e904a282a6bb276e88f15dcbd146df90fe3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/41ba8306deab4c0679ae5b0c3520d7a6525c4818e90446a651a590d7de1ae2d55bd92d521e82d9792c95823e2d22a375e5a619e37de451ed24fd6abbaf3fac7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/dcd7df8f82f4a665de2f4395766ec7d1a75c2393919ca49380096ce7096a12d46c9887e8612a9db3915c82b6c7748396dd27036e4904e50c53f84fc5419faba7"} 10:45:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:45:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:45:23 INFO - Contents: 10:45:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1d49eebcb839341c2738a605fc08a066e2e8b545bdc8d8977b260363749a7a56bb3bb83db990211a3c636b209a4e904a282a6bb276e88f15dcbd146df90fe3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/41ba8306deab4c0679ae5b0c3520d7a6525c4818e90446a651a590d7de1ae2d55bd92d521e82d9792c95823e2d22a375e5a619e37de451ed24fd6abbaf3fac7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/dcd7df8f82f4a665de2f4395766ec7d1a75c2393919ca49380096ce7096a12d46c9887e8612a9db3915c82b6c7748396dd27036e4904e50c53f84fc5419faba7"} 10:45:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:45:23 INFO - Copying logs to upload dir... 10:45:23 INFO - mkdir: /builds/slave/test/build/upload/logs 10:45:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.259920 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 10:45:22.831218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 10:45:22.834746) ========= 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=cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1d49eebcb839341c2738a605fc08a066e2e8b545bdc8d8977b260363749a7a56bb3bb83db990211a3c636b209a4e904a282a6bb276e88f15dcbd146df90fe3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/41ba8306deab4c0679ae5b0c3520d7a6525c4818e90446a651a590d7de1ae2d55bd92d521e82d9792c95823e2d22a375e5a619e37de451ed24fd6abbaf3fac7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/dcd7df8f82f4a665de2f4395766ec7d1a75c2393919ca49380096ce7096a12d46c9887e8612a9db3915c82b6c7748396dd27036e4904e50c53f84fc5419faba7"} build_url:https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011543 build_url: 'https://queue.taskcluster.net/v1/task/D5egX9tdQLWSMOkjE6mQIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/1d49eebcb839341c2738a605fc08a066e2e8b545bdc8d8977b260363749a7a56bb3bb83db990211a3c636b209a4e904a282a6bb276e88f15dcbd146df90fe3c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/41ba8306deab4c0679ae5b0c3520d7a6525c4818e90446a651a590d7de1ae2d55bd92d521e82d9792c95823e2d22a375e5a619e37de451ed24fd6abbaf3fac7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/dcd7df8f82f4a665de2f4395766ec7d1a75c2393919ca49380096ce7096a12d46c9887e8612a9db3915c82b6c7748396dd27036e4904e50c53f84fc5419faba7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 10:45:22.860332) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:45:22.860645) ========= 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=cbe409c6de289db6ac707de3000001d4-1465320280.380785-434048814 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 10:45:22.943807) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 10:45:22.944113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 10:45:22.944421) ========= ========= Total master_lag: 0.15 =========