builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1467106126.44 results: success (0) buildid: 20160627223058 builduid: 7ce57ad2a4e64d6cb7e4e5234b1bf8bf revision: e30eb329b1320c54228eb5fd5a6f4246f0558241 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.443567) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.444072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.444384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.459476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.459937) ========= 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=fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 02:28:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.6M=0.001s 2016-06-28 02:28:46 (19.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.561539) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.562228) ========= 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=fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018674 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.614816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:46.615569) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e30eb329b1320c54228eb5fd5a6f4246f0558241 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e30eb329b1320c54228eb5fd5a6f4246f0558241 --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=fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 02:28:47,037 truncating revision to first 12 chars 2016-06-28 02:28:47,037 Setting DEBUG logging. 2016-06-28 02:28:47,038 attempt 1/10 2016-06-28 02:28:47,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e30eb329b132?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 02:28:47,362 unpacking tar archive at: mozilla-inbound-e30eb329b132/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:47.302279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:47.302691) ========= script_repo_revision: e30eb329b1320c54228eb5fd5a6f4246f0558241 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:47.303211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:47.303578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:28:47.313273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 02:28:47.313623) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:28:47 INFO - MultiFileLogger online at 20160628 02:28:47 in /builds/slave/test 02:28:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:28:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:28:47 INFO - {'append_to_log': False, 02:28:47 INFO - 'base_work_dir': '/builds/slave/test', 02:28:47 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:28:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:28:47 INFO - 'branch': 'Mozilla-Inbound', 02:28:47 INFO - 'buildbot_json_path': 'buildprops.json', 02:28:47 INFO - 'config_files': ('talos/linux_config.py',), 02:28:47 INFO - 'default_actions': ('clobber', 02:28:47 INFO - 'read-buildbot-config', 02:28:47 INFO - 'download-and-extract', 02:28:47 INFO - 'populate-webroot', 02:28:47 INFO - 'create-virtualenv', 02:28:47 INFO - 'install', 02:28:47 INFO - 'run-tests'), 02:28:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:28:47 INFO - 'download_minidump_stackwalk': True, 02:28:47 INFO - 'download_symbols': 'ondemand', 02:28:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:28:47 INFO - 'tooltool.py': '/tools/tooltool.py', 02:28:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:28:47 INFO - '/tools/misc-python/virtualenv.py')}, 02:28:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:28:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:28:47 INFO - 'installer_path': 'installer.exe', 02:28:47 INFO - 'log_level': 'info', 02:28:47 INFO - 'log_name': 'talos', 02:28:47 INFO - 'log_to_console': True, 02:28:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:28:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:28:47 INFO - 'opt_config_files': (), 02:28:47 INFO - 'pip_index': False, 02:28:47 INFO - 'sps_profile': False, 02:28:47 INFO - 'sps_profile_interval': 0, 02:28:47 INFO - 'suite': 'dromaeojs', 02:28:47 INFO - 'system_bits': '32', 02:28:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:28:47 INFO - 'title': 'talos-linux64-ix-048', 02:28:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:28:47 INFO - 'use_talos_json': True, 02:28:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:28:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:28:47 INFO - 'work_dir': 'build'} 02:28:47 INFO - ##### 02:28:47 INFO - ##### Running clobber step. 02:28:47 INFO - ##### 02:28:47 INFO - Running pre-action listener: _resource_record_pre_action 02:28:47 INFO - Running main action method: clobber 02:28:47 INFO - rmtree: /builds/slave/test/build 02:28:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:28:48 INFO - Running post-action listener: _resource_record_post_action 02:28:48 INFO - ##### 02:28:48 INFO - ##### Finished clobber step (success) 02:28:48 INFO - ##### 02:28:48 INFO - ##### 02:28:48 INFO - ##### Running read-buildbot-config step. 02:28:48 INFO - ##### 02:28:48 INFO - Running pre-action listener: _resource_record_pre_action 02:28:48 INFO - Running main action method: read_buildbot_config 02:28:48 INFO - Using buildbot properties: 02:28:48 INFO - { 02:28:48 INFO - "project": "", 02:28:48 INFO - "product": "firefox", 02:28:48 INFO - "script_repo_revision": "production", 02:28:48 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:28:48 INFO - "repository": "", 02:28:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:28:48 INFO - "buildid": "20160627223058", 02:28:48 INFO - "pgo_build": "True", 02:28:48 INFO - "basedir": "/builds/slave/test", 02:28:48 INFO - "buildnumber": 1179, 02:28:48 INFO - "slavename": "talos-linux64-ix-048", 02:28:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:28:48 INFO - "platform": "ubuntu64_hw", 02:28:48 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:28:48 INFO - "branch": "mozilla-inbound", 02:28:48 INFO - "repo_path": "integration/mozilla-inbound", 02:28:48 INFO - "revision": "e30eb329b1320c54228eb5fd5a6f4246f0558241", 02:28:48 INFO - "stage_platform": "linux64-pgo", 02:28:48 INFO - "builduid": "7ce57ad2a4e64d6cb7e4e5234b1bf8bf", 02:28:48 INFO - "slavebuilddir": "test" 02:28:48 INFO - } 02:28:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:28:48 INFO - Running post-action listener: _resource_record_post_action 02:28:48 INFO - ##### 02:28:48 INFO - ##### Finished read-buildbot-config step (success) 02:28:48 INFO - ##### 02:28:48 INFO - ##### 02:28:48 INFO - ##### Running download-and-extract step. 02:28:48 INFO - ##### 02:28:48 INFO - Running pre-action listener: _resource_record_pre_action 02:28:48 INFO - Running main action method: download_and_extract 02:28:48 INFO - mkdir: /builds/slave/test/build/tests 02:28: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')]} 02:28:48 INFO - https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:48 INFO - Downloaded 1361 bytes. 02:28:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:28:48 INFO - Using the following test package requirements: 02:28:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:28:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:28:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:28:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'jsshell-linux-x86_64.zip'], 02:28:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:28:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:28:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:28:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:28:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:28:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:28:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:28:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:28: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')]} 02:28:48 INFO - https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:49 INFO - Downloaded 24282915 bytes. 02:28:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:28:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:28:51 INFO - Return code: 0 02:28:51 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 02:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:51 INFO - https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:28:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:28:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:52 INFO - Downloaded 24282915 bytes. 02:28:52 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'] 02:28:52 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 02:28:53 INFO - Return code: 0 02:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:53 INFO - https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:28:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:28:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:28:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:54 INFO - Downloaded 14405240 bytes. 02:28:54 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'] 02:28:54 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 02:28:54 INFO - Return code: 0 02:28: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')]} 02:28:54 INFO - https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:28:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/coef1JoHRl-1MDVFBqozgA/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 02:28:56 INFO - Downloaded 60295753 bytes. 02:28:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:56 INFO - mkdir: /builds/slave/test/properties 02:28:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:28:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:28:56 INFO - Contents: 02:28:56 INFO - build_url:https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:28:57 INFO - Running post-action listener: _resource_record_post_action 02:28:57 INFO - Running post-action listener: set_extra_try_arguments 02:28:57 INFO - ##### 02:28:57 INFO - ##### Finished download-and-extract step (success) 02:28:57 INFO - ##### 02:28:57 INFO - ##### 02:28:57 INFO - ##### Running populate-webroot step. 02:28:57 INFO - ##### 02:28:57 INFO - Running pre-action listener: _resource_record_pre_action 02:28:57 INFO - Running main action method: populate_webroot 02:28:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:28:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:28:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:28:57 INFO - '--tppagecycles', 02:28:57 INFO - '7'], 02:28:57 INFO - 'tests': ['tsvgm']}}, 02:28:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:28:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:28:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:28:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:28:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:28:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['damp', 'tps']}, 02:28:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'tests': ['damp', 'tps']}, 02:28:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['dromaeo_dom']}, 02:28:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:28:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['basic_compositor_video']}, 02:28:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:28:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['a11yr', 02:28:57 INFO - 'ts_paint', 02:28:57 INFO - 'tpaint', 02:28:57 INFO - 'sessionrestore', 02:28:57 INFO - 'sessionrestore_no_auto_restore', 02:28:57 INFO - 'tabpaint']}, 02:28:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:28:57 INFO - 'ts_paint', 02:28:57 INFO - 'tpaint', 02:28:57 INFO - 'sessionrestore', 02:28:57 INFO - 'sessionrestore_no_auto_restore', 02:28:57 INFO - 'tabpaint']}, 02:28:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:28:57 INFO - 'ts_paint', 02:28:57 INFO - 'tpaint', 02:28:57 INFO - 'sessionrestore', 02:28:57 INFO - 'sessionrestore_no_auto_restore', 02:28:57 INFO - 'tabpaint']}, 02:28:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:28:57 INFO - 'ts_paint', 02:28:57 INFO - 'tpaint', 02:28:57 INFO - 'sessionrestore', 02:28:57 INFO - 'sessionrestore_no_auto_restore', 02:28:57 INFO - 'tabpaint']}, 02:28:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['a11yr', 02:28:57 INFO - 'ts_paint', 02:28:57 INFO - 'tpaint', 02:28:57 INFO - 'sessionrestore', 02:28:57 INFO - 'sessionrestore_no_auto_restore', 02:28:57 INFO - 'tabpaint']}, 02:28:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['a11yr', 02:28:57 INFO - 'ts_paint', 02:28:57 INFO - 'tpaint', 02:28:57 INFO - 'sessionrestore', 02:28:57 INFO - 'sessionrestore_no_auto_restore', 02:28:57 INFO - 'tabpaint']}, 02:28:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['tsvgx', 02:28:57 INFO - 'tsvgr_opacity', 02:28:57 INFO - 'tart', 02:28:57 INFO - 'tscrollx', 02:28:57 INFO - 'cart']}, 02:28:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:28:57 INFO - 'tsvgr_opacity', 02:28:57 INFO - 'tart', 02:28:57 INFO - 'tscrollx', 02:28:57 INFO - 'cart']}, 02:28:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'talos_options': ['--disable-e10s'], 02:28:57 INFO - 'tests': ['tp5o']}, 02:28:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'tests': ['tp5o']}, 02:28:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'talos_options': ['--disable-e10s', 02:28:57 INFO - '--xperf_path', 02:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:57 INFO - 'tests': ['tp5n']}, 02:28:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:28:57 INFO - 'talos_options': ['--xperf_path', 02:28:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:28:57 INFO - 'tests': ['tp5n']}}, 02:28:57 INFO - 'talos.zip': {'path': '', 02:28:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:28:57 INFO - Running post-action listener: _resource_record_post_action 02:28:57 INFO - ##### 02:28:57 INFO - ##### Finished populate-webroot step (success) 02:28:57 INFO - ##### 02:28:57 INFO - ##### 02:28:57 INFO - ##### Running create-virtualenv step. 02:28:57 INFO - ##### 02:28:57 INFO - Running pre-action listener: _resource_record_pre_action 02:28:57 INFO - Running main action method: create_virtualenv 02:28:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:28:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:28:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:28:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:28:57 INFO - Using real prefix '/usr' 02:28:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:28:57 INFO - Installing distribute.............................................................................................................................................................................................done. 02:28:59 INFO - Installing pip.................done. 02:28:59 INFO - Return code: 0 02:28:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28: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', 'pip>=1.5'] in /builds/slave/test/build 02:28: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 pip>=1.5 02:28:59 INFO - Using env: {'DISPLAY': ':0', 02:28:59 INFO - 'HOME': '/home/cltbld', 02:28:59 INFO - 'LANG': 'en_US.UTF-8', 02:28:59 INFO - 'LANGUAGE': 'en_US:en', 02:28:59 INFO - 'LOGNAME': 'cltbld', 02:28:59 INFO - 'MAIL': '/var/mail/cltbld', 02:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:59 INFO - 'MOZ_NO_REMOTE': '1', 02:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:59 INFO - 'NO_EM_RESTART': '1', 02:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:59 INFO - 'PWD': '/builds/slave/test', 02:28:59 INFO - 'SHELL': '/bin/bash', 02:28:59 INFO - 'SHLVL': '1', 02:28:59 INFO - 'TERM': 'linux', 02:28:59 INFO - 'TMOUT': '86400', 02:28:59 INFO - 'USER': 'cltbld', 02:28:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:59 INFO - '_': '/tools/buildbot/bin/python'} 02:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:28:59 INFO - Cleaning up... 02:28:59 INFO - Return code: 0 02:28:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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', '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 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:28: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 psutil>=3.1.1 02:28:59 INFO - Using env: {'DISPLAY': ':0', 02:28:59 INFO - 'HOME': '/home/cltbld', 02:28:59 INFO - 'LANG': 'en_US.UTF-8', 02:28:59 INFO - 'LANGUAGE': 'en_US:en', 02:28:59 INFO - 'LOGNAME': 'cltbld', 02:28:59 INFO - 'MAIL': '/var/mail/cltbld', 02:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:59 INFO - 'MOZ_NO_REMOTE': '1', 02:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:59 INFO - 'NO_EM_RESTART': '1', 02:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:59 INFO - 'PWD': '/builds/slave/test', 02:28:59 INFO - 'SHELL': '/bin/bash', 02:28:59 INFO - 'SHLVL': '1', 02:28:59 INFO - 'TERM': 'linux', 02:28:59 INFO - 'TMOUT': '86400', 02:28:59 INFO - 'USER': 'cltbld', 02:28:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:59 INFO - '_': '/tools/buildbot/bin/python'} 02:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:00 INFO - Downloading/unpacking psutil>=3.1.1 02:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:29:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:02 INFO - Installing collected packages: psutil 02:29:02 INFO - Running setup.py install for psutil 02:29:02 INFO - building 'psutil._psutil_linux' extension 02:29:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:29:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:29:02 INFO - building 'psutil._psutil_posix' extension 02:29:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:29:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:29:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:02 INFO - Successfully installed psutil 02:29:02 INFO - Cleaning up... 02:29:02 INFO - Return code: 0 02:29:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:29: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 mozsystemmonitor==0.3 02:29:02 INFO - Using env: {'DISPLAY': ':0', 02:29:02 INFO - 'HOME': '/home/cltbld', 02:29:02 INFO - 'LANG': 'en_US.UTF-8', 02:29:02 INFO - 'LANGUAGE': 'en_US:en', 02:29:02 INFO - 'LOGNAME': 'cltbld', 02:29:02 INFO - 'MAIL': '/var/mail/cltbld', 02:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:02 INFO - 'MOZ_NO_REMOTE': '1', 02:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:02 INFO - 'NO_EM_RESTART': '1', 02:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:02 INFO - 'PWD': '/builds/slave/test', 02:29:02 INFO - 'SHELL': '/bin/bash', 02:29:02 INFO - 'SHLVL': '1', 02:29:02 INFO - 'TERM': 'linux', 02:29:02 INFO - 'TMOUT': '86400', 02:29:02 INFO - 'USER': 'cltbld', 02:29:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:02 INFO - '_': '/tools/buildbot/bin/python'} 02:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:29:04 INFO - Installing collected packages: mozsystemmonitor 02:29:04 INFO - Running setup.py install for mozsystemmonitor 02:29:04 INFO - Successfully installed mozsystemmonitor 02:29:04 INFO - Cleaning up... 02:29:05 INFO - Return code: 0 02:29:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:29:05 INFO - Using env: {'DISPLAY': ':0', 02:29:05 INFO - 'HOME': '/home/cltbld', 02:29:05 INFO - 'LANG': 'en_US.UTF-8', 02:29:05 INFO - 'LANGUAGE': 'en_US:en', 02:29:05 INFO - 'LOGNAME': 'cltbld', 02:29:05 INFO - 'MAIL': '/var/mail/cltbld', 02:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:05 INFO - 'MOZ_NO_REMOTE': '1', 02:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:05 INFO - 'NO_EM_RESTART': '1', 02:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:05 INFO - 'PWD': '/builds/slave/test', 02:29:05 INFO - 'SHELL': '/bin/bash', 02:29:05 INFO - 'SHLVL': '1', 02:29:05 INFO - 'TERM': 'linux', 02:29:05 INFO - 'TMOUT': '86400', 02:29:05 INFO - 'USER': 'cltbld', 02:29:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:05 INFO - '_': '/tools/buildbot/bin/python'} 02:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:05 INFO - Downloading/unpacking jsonschema==2.5.1 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:29:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:29:07 INFO - warning: no files found matching '*.txt' 02:29:07 INFO - no previously-included directories found matching 'build' 02:29:07 INFO - no previously-included directories found matching 'dist' 02:29:07 INFO - no previously-included directories found matching '.git*' 02:29:07 INFO - Installing collected packages: jsonschema, functools32 02:29:07 INFO - Running setup.py install for functools32 02:29:07 INFO - warning: no files found matching '*.txt' 02:29:07 INFO - no previously-included directories found matching 'build' 02:29:07 INFO - no previously-included directories found matching 'dist' 02:29:07 INFO - no previously-included directories found matching '.git*' 02:29:07 INFO - Successfully installed jsonschema functools32 02:29:07 INFO - Cleaning up... 02:29:07 INFO - Return code: 0 02:29:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:07 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 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:29:07 INFO - Using env: {'DISPLAY': ':0', 02:29:07 INFO - 'HOME': '/home/cltbld', 02:29:07 INFO - 'LANG': 'en_US.UTF-8', 02:29:07 INFO - 'LANGUAGE': 'en_US:en', 02:29:07 INFO - 'LOGNAME': 'cltbld', 02:29:07 INFO - 'MAIL': '/var/mail/cltbld', 02:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:07 INFO - 'MOZ_NO_REMOTE': '1', 02:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:07 INFO - 'NO_EM_RESTART': '1', 02:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:07 INFO - 'PWD': '/builds/slave/test', 02:29:07 INFO - 'SHELL': '/bin/bash', 02:29:07 INFO - 'SHLVL': '1', 02:29:07 INFO - 'TERM': 'linux', 02:29:07 INFO - 'TMOUT': '86400', 02:29:07 INFO - 'USER': 'cltbld', 02:29:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:07 INFO - '_': '/tools/buildbot/bin/python'} 02:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:07 INFO - Downloading/unpacking blobuploader==1.2.4 02:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:29:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29:10 INFO - Downloading docopt-0.6.1.tar.gz 02:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:10 INFO - Running setup.py install for blobuploader 02:29:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:10 INFO - Running setup.py install for requests 02:29:10 INFO - Running setup.py install for docopt 02:29:11 INFO - Successfully installed blobuploader requests docopt 02:29:11 INFO - Cleaning up... 02:29:11 INFO - Return code: 0 02:29:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:11 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 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:11 INFO - Using env: {'DISPLAY': ':0', 02:29:11 INFO - 'HOME': '/home/cltbld', 02:29:11 INFO - 'LANG': 'en_US.UTF-8', 02:29:11 INFO - 'LANGUAGE': 'en_US:en', 02:29:11 INFO - 'LOGNAME': 'cltbld', 02:29:11 INFO - 'MAIL': '/var/mail/cltbld', 02:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:11 INFO - 'MOZ_NO_REMOTE': '1', 02:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:11 INFO - 'NO_EM_RESTART': '1', 02:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:11 INFO - 'PWD': '/builds/slave/test', 02:29:11 INFO - 'SHELL': '/bin/bash', 02:29:11 INFO - 'SHLVL': '1', 02:29:11 INFO - 'TERM': 'linux', 02:29:11 INFO - 'TMOUT': '86400', 02:29:11 INFO - 'USER': 'cltbld', 02:29:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:11 INFO - '_': '/tools/buildbot/bin/python'} 02:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:11 INFO - Running setup.py (path:/tmp/pip-Y6uL2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:11 INFO - Running setup.py (path:/tmp/pip-DMVINu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:11 INFO - Running setup.py (path:/tmp/pip-EEvIkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:11 INFO - Running setup.py (path:/tmp/pip-_UdCsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:11 INFO - Running setup.py (path:/tmp/pip-oc0B86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:11 INFO - Running setup.py (path:/tmp/pip-khK7Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:11 INFO - Running setup.py (path:/tmp/pip-iChZsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:11 INFO - Running setup.py (path:/tmp/pip-oSIuFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:11 INFO - Running setup.py (path:/tmp/pip-Lx6jVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:11 INFO - Running setup.py (path:/tmp/pip-w4jc_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:12 INFO - Running setup.py (path:/tmp/pip-w8ZT6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:12 INFO - Running setup.py (path:/tmp/pip-hQXRcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:12 INFO - Running setup.py (path:/tmp/pip-Eq43Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:12 INFO - Running setup.py (path:/tmp/pip-NokqKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:12 INFO - Running setup.py (path:/tmp/pip-FAXd47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:12 INFO - Running setup.py (path:/tmp/pip-unSls2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:12 INFO - Running setup.py (path:/tmp/pip-39ocRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:12 INFO - Running setup.py install for manifestparser 02:29:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:12 INFO - Running setup.py install for mozcrash 02:29:12 INFO - Running setup.py install for mozdebug 02:29:12 INFO - Running setup.py install for mozdevice 02:29:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:12 INFO - Running setup.py install for mozfile 02:29:13 INFO - Running setup.py install for mozhttpd 02:29:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Running setup.py install for mozinfo 02:29:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Running setup.py install for mozInstall 02:29:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Running setup.py install for mozleak 02:29:13 INFO - Running setup.py install for mozlog 02:29:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Running setup.py install for moznetwork 02:29:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Running setup.py install for mozprocess 02:29:13 INFO - Running setup.py install for mozprofile 02:29:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:13 INFO - Running setup.py install for mozrunner 02:29:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:14 INFO - Running setup.py install for mozscreenshot 02:29:14 INFO - Running setup.py install for moztest 02:29:14 INFO - Running setup.py install for mozversion 02:29:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:14 INFO - Cleaning up... 02:29:14 INFO - Return code: 0 02:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:14 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 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:14 INFO - Using env: {'DISPLAY': ':0', 02:29:14 INFO - 'HOME': '/home/cltbld', 02:29:14 INFO - 'LANG': 'en_US.UTF-8', 02:29:14 INFO - 'LANGUAGE': 'en_US:en', 02:29:14 INFO - 'LOGNAME': 'cltbld', 02:29:14 INFO - 'MAIL': '/var/mail/cltbld', 02:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:14 INFO - 'MOZ_NO_REMOTE': '1', 02:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:14 INFO - 'NO_EM_RESTART': '1', 02:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:14 INFO - 'PWD': '/builds/slave/test', 02:29:14 INFO - 'SHELL': '/bin/bash', 02:29:14 INFO - 'SHLVL': '1', 02:29:14 INFO - 'TERM': 'linux', 02:29:14 INFO - 'TMOUT': '86400', 02:29:14 INFO - 'USER': 'cltbld', 02:29:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:14 INFO - '_': '/tools/buildbot/bin/python'} 02:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:14 INFO - Running setup.py (path:/tmp/pip-f0bjFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:14 INFO - Running setup.py (path:/tmp/pip-VEV3Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:14 INFO - Running setup.py (path:/tmp/pip-KJHuck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:14 INFO - Running setup.py (path:/tmp/pip-Ahv3x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:14 INFO - Running setup.py (path:/tmp/pip-kC2qcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:14 INFO - Running setup.py (path:/tmp/pip-flelw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:14 INFO - Running setup.py (path:/tmp/pip-tXS7eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:15 INFO - Running setup.py (path:/tmp/pip-sQ2y6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:15 INFO - Running setup.py (path:/tmp/pip-0P3VAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:15 INFO - Running setup.py (path:/tmp/pip-yGD9Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:15 INFO - Running setup.py (path:/tmp/pip-D5xB2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:15 INFO - Running setup.py (path:/tmp/pip-KjctMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:15 INFO - Running setup.py (path:/tmp/pip-H3dkir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:15 INFO - Running setup.py (path:/tmp/pip-gLo17i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:15 INFO - Running setup.py (path:/tmp/pip-q849Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:15 INFO - Running setup.py (path:/tmp/pip-x4eWur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:15 INFO - Running setup.py (path:/tmp/pip-eKrJX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29:17 INFO - Downloading blessings-1.6.tar.gz 02:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:17 INFO - Installing collected packages: blessings 02:29:17 INFO - Running setup.py install for blessings 02:29:17 INFO - Successfully installed blessings 02:29:17 INFO - Cleaning up... 02:29:17 INFO - Return code: 0 02:29:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:18 INFO - Reading from file tmpfile_stdout 02:29:18 INFO - Current package versions: 02:29:18 INFO - argparse == 1.2.1 02:29:18 INFO - blessings == 1.6 02:29:18 INFO - blobuploader == 1.2.4 02:29:18 INFO - docopt == 0.6.1 02:29:18 INFO - functools32 == 3.2.3-2 02:29:18 INFO - jsonschema == 2.5.1 02:29:18 INFO - manifestparser == 1.1 02:29:18 INFO - mozInstall == 1.12 02:29:18 INFO - mozcrash == 0.17 02:29:18 INFO - mozdebug == 0.1 02:29:18 INFO - mozdevice == 0.48 02:29:18 INFO - mozfile == 1.2 02:29:18 INFO - mozhttpd == 0.7 02:29:18 INFO - mozinfo == 0.9 02:29:18 INFO - mozleak == 0.1 02:29:18 INFO - mozlog == 3.2 02:29:18 INFO - moznetwork == 0.27 02:29:18 INFO - mozprocess == 0.22 02:29:18 INFO - mozprofile == 0.28 02:29:18 INFO - mozrunner == 6.11 02:29:18 INFO - mozscreenshot == 0.1 02:29:18 INFO - mozsystemmonitor == 0.3 02:29:18 INFO - moztest == 0.7 02:29:18 INFO - mozversion == 1.4 02:29:18 INFO - psutil == 3.1.1 02:29:18 INFO - requests == 1.2.3 02:29:18 INFO - wsgiref == 0.1.2 02:29:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:18 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 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:18 INFO - Using env: {'DISPLAY': ':0', 02:29:18 INFO - 'HOME': '/home/cltbld', 02:29:18 INFO - 'LANG': 'en_US.UTF-8', 02:29:18 INFO - 'LANGUAGE': 'en_US:en', 02:29:18 INFO - 'LOGNAME': 'cltbld', 02:29:18 INFO - 'MAIL': '/var/mail/cltbld', 02:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:18 INFO - 'MOZ_NO_REMOTE': '1', 02:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:18 INFO - 'NO_EM_RESTART': '1', 02:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:18 INFO - 'PWD': '/builds/slave/test', 02:29:18 INFO - 'SHELL': '/bin/bash', 02:29:18 INFO - 'SHLVL': '1', 02:29:18 INFO - 'TERM': 'linux', 02:29:18 INFO - 'TMOUT': '86400', 02:29:18 INFO - 'USER': 'cltbld', 02:29:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:18 INFO - '_': '/tools/buildbot/bin/python'} 02:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:29:18 INFO - Cleaning up... 02:29:18 INFO - Return code: 0 02:29:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:29:18 INFO - Using env: {'DISPLAY': ':0', 02:29:18 INFO - 'HOME': '/home/cltbld', 02:29:18 INFO - 'LANG': 'en_US.UTF-8', 02:29:18 INFO - 'LANGUAGE': 'en_US:en', 02:29:18 INFO - 'LOGNAME': 'cltbld', 02:29:18 INFO - 'MAIL': '/var/mail/cltbld', 02:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:18 INFO - 'MOZ_NO_REMOTE': '1', 02:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:18 INFO - 'NO_EM_RESTART': '1', 02:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:18 INFO - 'PWD': '/builds/slave/test', 02:29:18 INFO - 'SHELL': '/bin/bash', 02:29:18 INFO - 'SHLVL': '1', 02:29:18 INFO - 'TERM': 'linux', 02:29:18 INFO - 'TMOUT': '86400', 02:29:18 INFO - 'USER': 'cltbld', 02:29:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:18 INFO - '_': '/tools/buildbot/bin/python'} 02:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:29:18 INFO - Cleaning up... 02:29:18 INFO - Return code: 0 02:29:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67cb80af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216f480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, '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': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:29:18 INFO - Using env: {'DISPLAY': ':0', 02:29:18 INFO - 'HOME': '/home/cltbld', 02:29:18 INFO - 'LANG': 'en_US.UTF-8', 02:29:18 INFO - 'LANGUAGE': 'en_US:en', 02:29:18 INFO - 'LOGNAME': 'cltbld', 02:29:18 INFO - 'MAIL': '/var/mail/cltbld', 02:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:18 INFO - 'MOZ_NO_REMOTE': '1', 02:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:18 INFO - 'NO_EM_RESTART': '1', 02:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:18 INFO - 'PWD': '/builds/slave/test', 02:29:18 INFO - 'SHELL': '/bin/bash', 02:29:18 INFO - 'SHLVL': '1', 02:29:18 INFO - 'TERM': 'linux', 02:29:18 INFO - 'TMOUT': '86400', 02:29:18 INFO - 'USER': 'cltbld', 02:29:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:18 INFO - '_': '/tools/buildbot/bin/python'} 02:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:18 INFO - Downloading/unpacking flake8 02:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:29:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:29:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:29:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:21 INFO - no previously-included directories found matching 'docs/_build' 02:29:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:29:21 INFO - Running setup.py install for pep8 02:29:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:21 INFO - no previously-included directories found matching 'docs/_build' 02:29:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:29:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:29:21 INFO - Cleaning up... 02:29:21 INFO - Return code: 0 02:29:21 INFO - Running post-action listener: _resource_record_post_action 02:29:21 INFO - Running post-action listener: _start_resource_monitoring 02:29:21 INFO - Starting resource monitoring. 02:29:21 INFO - ##### 02:29:21 INFO - ##### Finished create-virtualenv step (success) 02:29:21 INFO - ##### 02:29:21 INFO - ##### 02:29:21 INFO - ##### Running install step. 02:29:21 INFO - ##### 02:29:21 INFO - Running pre-action listener: _resource_record_pre_action 02:29:21 INFO - Running main action method: install 02:29:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:21 INFO - Reading from file tmpfile_stdout 02:29:21 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:21 INFO - Reading from file tmpfile_stdout 02:29:21 INFO - Output received: 02:29:21 INFO - Usage: mozinstall [options] installer 02:29:21 INFO - Options: 02:29:21 INFO - -h, --help show this help message and exit 02:29:21 INFO - -d DEST, --destination=DEST 02:29:21 INFO - Directory to install application into. [default: 02:29:21 INFO - "/builds/slave/test"] 02:29:21 INFO - --app=APP Application being installed. [default: firefox] 02:29:21 INFO - mkdir: /builds/slave/test/build/application 02:29:21 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'] 02:29:21 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 02:29:39 INFO - Reading from file tmpfile_stdout 02:29:39 INFO - Output received: 02:29:39 INFO - /builds/slave/test/build/application/firefox/firefox 02:29:39 INFO - Running post-action listener: _resource_record_post_action 02:29:39 INFO - ##### 02:29:39 INFO - ##### Finished install step (success) 02:29:39 INFO - ##### 02:29:39 INFO - ##### 02:29:39 INFO - ##### Running run-tests step. 02:29:39 INFO - ##### 02:29:39 INFO - Running pre-action listener: _resource_record_pre_action 02:29:39 INFO - Running main action method: run_tests 02:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:29:39 INFO - Python 2.7.3 02:29:39 INFO - Return code: 0 02:29:39 INFO - grabbing minidump binary from tooltool 02:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:39 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 0x21fe6f0>, '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 0x21ff5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ffaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:29:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:29:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:29:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:29:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:29:39 INFO - Return code: 0 02:29:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:29:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:29:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:29:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:29:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:29:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:29:40 INFO - Return code: 0 02:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:29:40 INFO - Using env: {'DISPLAY': ':0', 02:29:40 INFO - 'HOME': '/home/cltbld', 02:29:40 INFO - 'LANG': 'en_US.UTF-8', 02:29:40 INFO - 'LANGUAGE': 'en_US:en', 02:29:40 INFO - 'LOGNAME': 'cltbld', 02:29:40 INFO - 'MAIL': '/var/mail/cltbld', 02:29:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:29:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:40 INFO - 'MOZ_NO_REMOTE': '1', 02:29:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:40 INFO - 'NO_EM_RESTART': '1', 02:29:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:40 INFO - 'PWD': '/builds/slave/test', 02:29:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:29:40 INFO - 'SHELL': '/bin/bash', 02:29:40 INFO - 'SHLVL': '1', 02:29:40 INFO - 'TERM': 'linux', 02:29:40 INFO - 'TMOUT': '86400', 02:29:40 INFO - 'USER': 'cltbld', 02:29:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100', 02:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:40 INFO - '_': '/tools/buildbot/bin/python'} 02:29:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:29:40 INFO - mozversion application_buildid: 20160627223058 02:29:40 INFO - mozversion application_changeset: e30eb329b1320c54228eb5fd5a6f4246f0558241 02:29:40 INFO - mozversion application_display_name: Nightly 02:29:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:29:40 INFO - mozversion application_name: Firefox 02:29:40 INFO - mozversion application_remotingname: firefox 02:29:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:29:40 INFO - mozversion application_vendor: Mozilla 02:29:40 INFO - mozversion application_version: 50.0a1 02:29:40 INFO - mozversion platform_buildid: 20160627223058 02:29:40 INFO - mozversion platform_changeset: e30eb329b1320c54228eb5fd5a6f4246f0558241 02:29:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:29:40 INFO - mozversion platform_version: 50.0a1 02:29:40 INFO - using testdate: 1467106180 02:29:40 INFO - actual date: 1467106180 02:29:40 INFO - starting webserver on 'localhost:40303' 02:29:40 INFO - SUITE-START | Running 2 tests 02:29:40 INFO - TEST-START | dromaeo_css 02:29:40 INFO - operating with platform_type : linux_ 02:29:40 INFO - Initialising browser for dromaeo_css test... 02:29:40 INFO - TEST-INFO | started process 26193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNZI31/profile http://localhost:40303/getInfo.html) 02:29:44 INFO - PROCESS | 26193 | __metrics Screen width/height:1600/1200 02:29:44 INFO - PROCESS | 26193 | colorDepth:24 02:29:44 INFO - PROCESS | 26193 | Browser inner width/height: 1024/697 02:29:44 INFO - PROCESS | 26193 | __metrics 02:29:45 INFO - PROCESS | 26193 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:46 INFO - TEST-INFO | 26193: exit 0 02:29:46 INFO - Browser initialized. 02:29:46 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:46 INFO - TEST-INFO | started process 26277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkNZI31/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:58 INFO - PROCESS | 26277 | RSS: Main: 156479488 02:29:58 INFO - PROCESS | 26277 | 02:30:49 INFO - PROCESS | 26277 | 1467106249747 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:32:57 INFO - PROCESS | 26277 | Cycle 1(1): loaded http://localhost:40303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40303/tests/dromaeo/cssquery-ext.html) 02:32:58 INFO - PROCESS | 26277 | RSS: Main: 257921024 02:32:58 INFO - PROCESS | 26277 | 02:36:01 INFO - PROCESS | 26277 | Cycle 1(1): loaded http://localhost:40303/tests/dromaeo/cssquery-ext.html (next: http://localhost:40303/tests/dromaeo/cssquery-jquery.html) 02:36:01 INFO - PROCESS | 26277 | RSS: Main: 239288320 02:36:01 INFO - PROCESS | 26277 | 02:39:03 INFO - PROCESS | 26277 | Cycle 1(1): loaded http://localhost:40303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40303/tests/dromaeo/cssquery-mootools.html) 02:39:04 INFO - PROCESS | 26277 | RSS: Main: 238018560 02:39:04 INFO - PROCESS | 26277 | 02:42:06 INFO - PROCESS | 26277 | Cycle 1(1): loaded http://localhost:40303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40303/tests/dromaeo/cssquery-prototype.html) 02:42:07 INFO - PROCESS | 26277 | RSS: Main: 238047232 02:42:07 INFO - PROCESS | 26277 | 02:45:09 INFO - PROCESS | 26277 | Cycle 1(1): loaded http://localhost:40303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40303/tests/dromaeo/cssquery-yui.html) 02:45:10 INFO - PROCESS | 26277 | RSS: Main: 220221440 02:45:10 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | Cycle 1(1): loaded http://localhost:40303/tests/dromaeo/cssquery-yui.html (next: http://localhost:40303/tests/dromaeo/cssquery-dojo.html) 02:48:13 INFO - PROCESS | 26277 | RSS: Main: 281153536 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | __start_tp_report 02:48:13 INFO - PROCESS | 26277 | _x_x_mozilla_page_load 02:48:13 INFO - PROCESS | 26277 | _x_x_mozilla_page_load_details 02:48:13 INFO - PROCESS | 26277 | |i|pagename|runs| 02:48:13 INFO - PROCESS | 26277 | |0;dojo.html;3079;3082.7996180248283;3097.1792474994118;3112.735417489513;3148.102790704648;5200.6099542534275;5207.140821764414;5236.057509648262;5296.285001524793;5329.733513324328;5346.251524786533;5352.143657014878;5399.487048730374;5448.7548060337285;5506.779728810853;4850.078485087822;4895.534924182197;4915.3855768029;4936.975315123419;5067.93573349597;4993.400791904976;5008.449070602231;5039.521245481692;5067.214581739836;5076.187809950408;4788.592969597588;4846.975765121187;4850.757462126897;4854.951450485521;4878.634102442314;4865.5134486551415;4882;4939.703617782909;4945.307656928033;4979.775910084055;4784.40194975628;4914.4839791821705;4931.65478416511;4931.975340123312;4943.802247910079;5346.652467589594;5407.594430417695;5426.8371948841595;5502.339719233718;5517.917231241535;5811.82564523065;5859.941400585983;5881.264841894763;5889.204957330749;5892.616979896293;5576.944230557724;5708;5737.311522617271;5745.683987380692;5749.59752817303;5372.811951581676;5455.618106732531;5465.453454654582;5466.180072989084;5467.5625949923915;5940.049592065248;5951.940480595225;5953.28560572734;5956.970215148983;5959.880802384015;5474.42518535556;5586.804461843816;5620.241267428926;5716.628419152742;5730.914036289459;5764.193012978187;5804.709764511842;5819.53443724501;5819.82540523785;5820.068788993825;5708.942910570924;5731.426857314235;5747.3677895431465;5751.654900705971;5760.74076666551;5554.666719996813;5717.142428635738;5744.052231381859;5744.885102298014;5756.683382414008;4413.691041627119;4416;4416.271315232951;4418.226810308183;4458.464984201916;3933.527976642764;3940.625640564142;3952.9209415811524;3982.7012974026484;3994.46074779901;5207.713575753294;5305.124654431976;5364.088105022156;5416.51251387377;5419.376771671229;5776.855578610484;5794.82615521535;5795.507381872504;5801.216835727208;5840.240768700127;5464.972675136599;5473.972630136824;5474.781008759605;5479.671219726829;5480.314960629921;4778.737169455713;4882;4914.72968986702;4921.827736029293;4934.8026078957155;5947.37552556984;5953.613015154001;5955.7617695292565;5963.224780778471;5967;5607.074832652566;5698.544116470755;5720.2849643794525;5732.541396688338;5736.139579063007;5910.940890591211;5966.343702192842;5970.402959703995;5988.5508586855285;5988.700564971821;5614.185943038318;5636.88726225465;5645.661260324394;5656.8020119295625;5661.490465858093;5564.860878478071;5645.322561292671;5745.6552606843725;5751.3673495916255;5759.049756790083;5555;5599.888002239851;5609.49514543693;5610.6072574921;5659.066254068197;5528.86177845541;5570.164475328733;5578.832635020955;5580.609357344947;5587.944120558905;5352;5379.946200537945;5419.078756611464;5497.835064948058;5550.52820510245;5697.7436015380235;5713.742881570256;5719.599628025998;5724.313082430135;5726.513246374105;5535.667859928417;5536.944630553643;5539.695316757617;5541.861453463695;5553.111502159635 02:48:13 INFO - PROCESS | 26277 | |1;ext.html;587.7737071227576;625.6683957502526;629.2291942370595;638.6295948349955;647.1005302629345;32417.67582324176;35551;35571;35595.466068008966;43382.349264761055;41635;45510.54489455104;45528;45611.54388456123;45619.315710264375;8984.146506081912;9133.497657628828;9134.269258459308;9138.268938484938;9138.817223655524;8958.37291389603;9058.547072646374;9058.818823623524;9059.365844390863;9061.50161741104;9021.458712477272;9024.593893274818;9029.142231488031;9058.184763371295;9118.452892826419;8948.881389826272;9071.228945539637;9073.954630226806;9077.273818094536;9082;8889.422187557853;8958.462492250486;8981.371304008722;8981.595828187747;8983.146601072953;42593.78703106496;42706;43031;43049.35425968613;43072;3563.6614521620404;3659.3230252403123;3668.575518969206;3838.5777564467885;3989.3018721723583;31012.224694382596;33574.328513429595;33793;33809.83095084533;34005.82997085024;4296.720713153666;4371.060222052242;4374.387585737967;4387.934180987288;4521.909561808746;346391;353274;354973;355221;355585;35281.64718352835;36182.27635447329;36266.09334766599;63268;64235.678821605594;38048.809755951595;38085.23829523394;38176.427353589715;38203;38265;14652.267386630625;14731;14733.04235224707;14736.778948315783;14741.1892345922;12250.632481025583;12276.079294052803;12277.079219058607;12283.263004219776;12287.815682764765;8591.6992905248;8632.91367086321;8633.870491942625;8717.084706105894;8734.825303493895;3352.5138854866395;3365.22599802042;3366.1584603849037;3391.2878295557716;3409.4544872820725;1038.1953985661023;1045.2474218562622;1047.000114890278;1099.2085698297212;1129.6102844518628;33120.50319245213;33504.66495335064;33561.32877342439;33683.66316336854;34037.31925361479;1101.8787933327328;1145.1010956399186;1156.6587856582328;1159.3275899977994;1229.4774720743649;16975.915120424317;17740.20169092368;17872.642547148986;17885.374011909782;17927.820721792876;580418;585624;587560;587669;588019;59678.40321596815;60973.69513152406;61078;61269.08096378469;61377.69311153416;1242.7017515796324;1349.089364678838;1367.118208755367;1375.1817668487433;1384.8753612174953;32421;33730.494042589875;33873.661263388036;34204;34457.655423445445;51588;52026.47973520216;52119.218211726096;52178;52202.477975219765;397685;410047;411015;411063;411915;25328.493430131664;28185.295367615974;28609.42781144407;28736.568951465328;29369.7063029367;47696.28455573239;47729.28406073842;48736;49044.50955490399;49112;40503;41470.58529414788;41648;42326.36510452407;43002;41024;41077;41702.79148604238;42160.57839421566;42456.78771606122;40837.795811020755;41502.792486037375;41902.58097418987;42149.789251053546;42218.78890605527;34129;36670.84542426039;37130.628693712715;37628.623713762514;37694.434583481816;27693.307667307672;28258.576121357786;28301.858490707415;28435.43129137447;28460.857695711387 02:48:13 INFO - PROCESS | 26277 | |2;jquery.html;392.3232424068481;399.19362886968344;399.6542990313378;403.67907513526745;419.9013231890505;14125.576232713009;17456.825431745678;17838.64322713545;19615.313464028743;19630.90184549077;14966.17686027268;15575.766363504528;17074.658506829855;17869.57043436525;18798;1776.2273411066162;1782.037699642198;1782.2959930827315;1787.1421717575572;1882.992598959557;4076.082881351702;5635.887282254353;5743.339515955677;5744.827655170351;5925.31858836235;6174.938250617503;6249.3438188990185;6284.277308109557;6286.591371560857;6286.748530058792;6157.445829875311;6356.491480681558;6411.1024456576115;6428.871422571522;6434.5843914338775;5618.747156377973;5646.20953066571;5651.124075768263;5653.745581448845;5671.347795003545;13995.30023498821;16451.506454806375;20549.5890082199;21850.89074554633;21852.344429666977;2223.3330000999636;2336.9298921032396;2862.527682932314;2930.7362337389736;2944.05790147153;9462.148406643435;9920.90079099207;10035.29752917296;10345.793084138275;10408.47957602117;1930.9710354344695;1980.6731889238258;2020.6261841559358;2074.979250207494;2131.520407908208;71270.64364678196;75801.24198757997;76330;76766;82930.75603866007;10306.484675766182;10413.895861041445;10561.366318020944;10646.840297395545;11199.048080913051;15161.924190378977;15231.390744370323;15239.847601523843;15264.465743698916;15271.694566108616;8010.279074883289;8258.132896045829;8496.490210587384;8526.829463410697;8529;7197.712091516385;7449.839546531553;7459.888101678479;7487.47587668858;7539.208383119693;4315.913681726411;4466.285394336891;4555.316702494652;4791.353167322437;4842.249451335048;1861.8417434518217;1943.737595424628;1974.052454821665;1983.5636160044767;2008.4677560446494;913.3789023463976;980.7548112971757;1000.7448100734412;1035.534009695625;1036.0054347826172;17686.380976665754;18985.525361866064;19092.71360929587;19313.710294345598;19714.802851971584;950.1970834644715;967.8983706710694;1006.3609607899036;1036.4196050211906;1041.2815157541272;10347.896521034843;10759.89240107589;10830.67507974762;10850.620228291971;10867.076298514557;471581;475468;476982;480693;491424;57495;93206.53396733108;95528.52235738916;96509.51745241228;96672.51663741637;964.7250533597891;989.9406035637885;996.1930836022844;996.7707427291764;1013.3261381181579;16821.831781682515;16834.410795622094;16894.324227030782;17076.487705368858;17206.82793172102;41415.7929210352;41510.886683498255;42803;42932.78533607312;43042.56957430386;54176;56543.43456565381;56624;62663;63380.16211114185;10939.704027872518;11987;12006.699832504257;12177;12196.390180491117;12536.686582835502;12812.167209131376;12867.22796632205;13358.799618005543;13714.108582942476;10771.676849694522;10909;11372.37451940118;11454.713632159262;11735;8167.346612270885;8236.958815206126;11769.764604708029;11793;11896.345700986529;8089.393295502979;8151.5924203790755;8184;8223.342132629256;8344.749657510285;11573.942130289295;11806.173567850168;11860.703482413008;11876.584319548774;12299.75400492003;11644.88355116438;11738.530458781554;11755;11825.231359961575;11969.16215864916 02:48:13 INFO - PROCESS | 26277 | |3;mootools.html;1308.3196737696403;1449.1087980891753;1494.7384207763641;1605.9598510037256;1760.5158581390108;8621.396502244837;8996.68511602094;9020.188183063523;9142.405743626676;9147.268218542516;8841.292696584274;9023.23302519285;9025.323100767453;9026.27789776818;9034.322425818056;2011.2256781139295;2274.863508189514;2319.083961835074;2356.434455730621;2364.042562762084;2392.425817803732;2397.760223977597;2398.388410955204;2400.6519054737055;2402.723686776017;2289.748127705959;2291.8510296830736;2305.170138750049;2306.630939049752;2314.2941402872116;1915.4062240705357;2164.177612507237;2230.408941630469;2232.0402227042364;2233.497463070796;2284.326123793485;2300.2179259052004;2320.083566991046;2325.3489023073566;2326.999390262187;9174.08259174084;9324.440533568008;9350.90649093507;9353.251739860794;9363.62545498186;5323.813666521692;5449.618526703132;5456.672599644034;5458.645188062763;5468.398476167618;3318.386098571772;3374.780639258465;3438.157651375404;3439.2949445363643;3458.2910503347007;1099.5052226498028;1107.6787731557838;1118.972025699356;1121.7532142928542;1147.0594112827484;12869.4208760606;12899.419526121346;12905.806412903814;12922.676933076655;12937.611871643865;4519.841805536857;4590.196715574828;4709.670323077352;4746.905061898743;4751.691140075884;10795.676129716121;10812.243142979916;10813.513391897226;10821.513031913582;10825.458727063615;5255.237990491358;5287.180487024518;5304.071787437183;5313.017091838023;5316.202569614588;4449.243628583149;4639.744814035261;4753.976230118897;4773.0453909218295;4855.757212139379;4024.9697195564713;4060.675145988314;4087.448194493705;4092.1201941582704;4127.8968025799595;1291.373683763374;1309.7118633900527;1313.6650154210615;1325.3505782166862;1332.580237225271;820.7250571058643;903.4895284164426;923.8383282925461;930.5161316115582;957.9808403831885;5853.297604287428;5973.910391344133;6000.819975400745;6121.632702037892;6221.657808820558;463.4832162139258;467.5441444591496;469.94125734283216;469.9553542413465;481.55456203012074;4138.896527586834;4175.812088456027;4195.958040419618;4219.303814870574;4224.577542245751;11191.888081119247;11562.190646654653;11578;11674.591389301333;11694.824577631342;11497.252678575866;11555.826662600068;11562.595309164139;11564;11568;8099.716509922242;8387.664493420194;8434.15658434164;8465.873011904827;8658.913410865936;6070.332263450929;6277.686115694106;6333.1766870306565;6374.394432528902;6398.104265402754;10506;10676.572937082741;10789.62236321725;10798.56805727762;10912.890871091187;10680.412577308012;10967.561297548009;11001.889981100087;11095.11239100886;11102.2783519071;7402.814929626802;8115.837683246184;8151.1441298662785;8322.916770832215;8437.62030708632;8504.787380315542;8820.2061814437;8868.556572171494;8902.59938302791;8912.108789121035;7584.127825300161;7851;7919.445638805229;7931.2068793120225;8006.039275287003;7778.961105194438;7781.182975787461;7785.844283114419;7815.882761758465;7841.686332546634;7311.049563556704;7368.410527157922;7447.404207663482;7465.514741541782;7468.066491688539;5080.415752188545;5116.692998420107;5159.896802064013;5232.843014709565;5248.212768084818;5095.541401273903;5163.070647283525;5178.922316165336;5242.76407561653;5280.287161233185 02:48:13 INFO - PROCESS | 26277 | |4;prototype.html;328.1157281127361;333.65133435559835;340.5810852651238;341.7812599936043;342.245349005443;5286.603504737141;5304.098303288441;5320.9467905320935;5334.919976200355;5365.826840129749;5222.9477705222935;5245.659032162906;5257.737113144347;5282.709450980205;5287.947120528794;3956.248312820555;4002.4196491508715;4161.604647558477;4194.622483976442;4224.366345048252;4119.196756632443;4128;4137.1725654869;4155.838963738854;4160.4383408239955;3995.0823604669777;4148.854790082332;4150.937735933963;4156.688248381369;4171.541130475645;3963.8612648557305;4077.245709543744;4081.897887570369;4082.3060079786505;4091.7954102294766;3646.3072016316814;3651.908702282438;3658.579263384718;3660.103274697716;3672.4307732301536;5053.823116190915;5083.949160508385;5087.186050231982;5107.565856902131;5114.156164232897;4499.257622492285;4678.69588476748;4679.274712419547;4690.9530904690855;4709.693869898446;5337.439568845293;5349.117395629716;5353.116735738598;5416.295881535415;5426.720777273555;3985.4021896715435;3997.360422332413;4011.1576568920564;4036.8183431745642;4049.311617025113;5356.91964620531;5646.2377579027125;5666.263385759866;5669.716514174274;5690.374058853523;4008;4010.7593544386846;4021.1153546219784;4034.11249525104;4042.555318914917;4088.7920522917884;4092.795360232036;4108.157827645326;4117.732347397409;4133.4626498555;4445.377647129404;4640.535946405333;4681.625469962395;4721.669483136147;4724.692894961817;5487.780488780404;5507.917381239285;5508.063629183049;5508.614396992172;5536.501714845684;1399.8670126337981;1426.5934208750457;1427.750143724844;1428.264443811438;1430.7853821926794;902.1114202510522;912.4753266871576;921.576075005505;932.2076235200161;973.9415635061919;5243.685378877203;5297;5310.256564081032;5314.5748340132695;5327.946720532823;5557.499825015768;5562.666240025612;5575.498205161555;5577.995960727027;5589.80435684749;5058.544730974157;5237.6333656643665;5245.291885595396;5262.7631756571045;5355.732213389315;2945.4550908082074;2963.2147480917574;2979.284971606842;2989.9834056420486;2991.760659147263;5843.620164689281;5859.765609375662;5865.20819689345;5871.911921321183;5876.500497457764;5528.408641291411;5764.942350576524;5796.739146738322;5812.796552120655;5827.009408400582;5904.439078287556;5936.198613187251;5944.256967879015;5951.672658003851;6014.248218972629;5421.62048656606;5703.914441283467;5726.484616384545;5762.683052432157;5765.250517432707;5517.227588137584;5560.221568980265;5562.332520097614;5652.604317697722;5659.349174844946;5837.708114594168;5867.970660146672;5927.8221653350465;5993;6008.87982240344;4008.2584721826556;4099.85650502231;4104;4106.301928672193;4118.8352465901025;5669.149627555735;5674.631148975303;5738.626989245853;5756.791073874533;5777.595568310178;5383.596230282823;5432.701201433959;5543.972280138573;5557.194206839905;5626.887462250814;5512.283403157564;5517.399954013452;5518.392976772632;5518.806841760519;5543.722813859372;5269.262303277621;5474.288342515448;5475.672839043311;5514.6691198528215;5520.012795393574;5472.112121318139;5497.532709719719;5511.5315198207;5528.834134975958;5547.8890422190525;5375.56995440356;5404.54061404785;5414.783408663609;5429.701366424884;5437.945620543744 02:48:13 INFO - PROCESS | 26277 | |5;yui.html;733.6038539188838;771.5987686403071;772.470857462638;820.7270711230791;822.7038266224155;13177.209367437948;13747.587572372844;13806.516771912986;13830.930845345785;13931.442742290308;14556.417743290256;14762.852371476281;15044.323005464754;15057.24713764313;15062.322195501201;777.1451403456209;786.1234723283526;793.4406243598278;793.8531371696225;794.1343935110729;657.5594351784292;761.5887420792793;790.0164295452141;798.9800254993643;800.4436916343144;838.0195171649185;841.045413455726;841.4194205997873;841.7685136587427;841.7853447370912;828.2587084559345;828.747232094211;829.0134739659785;829.0134739659816;829.5064436660177;507.959363250939;596.272547492059;611.2084850119106;611.2817439508559;612.0604871522237;14900.105993640416;14918.776218356734;14935.925320373328;14977.326020329112;15017.474388396353;13703.246321452316;14191.716165676731;14216.14703117806;14541;14542.200178990151;11896.363945204412;12361.982574600275;12760.680982975407;12782.488700451971;12892.742145157139;4431.246688063037;4526.864194074183;4532.410786597721;4532.4334458192725;4614.584687378152;69416.3058369415;69506.65246673785;69562.65218673875;69611.30388696099;69633.30366696318;10580.841287380696;10686.946565267124;10754.247202695737;10917.508712107974;11133.610323638633;19477.707834382494;20484.283050093472;20506.179752810018;21142.47143821386;21184.364469065953;8822.911770882338;8883.600237989305;8891.777705557413;8896.955515222382;8900.554972251492;4548.647873108832;4605.631549476101;4670.813167473331;4688.929666055012;4735.005648813719;3367.1582104473882;3462.23830757233;3482.9477557836653;3489.9825500872334;3490.110021944439;603.4067130239414;609.4149616368247;614.9108379285068;622.9314775374705;625.08425157145;514.5086442447529;527.9678229062174;535.8499620106377;576.7519966414482;659.980200593983;8592.65629374818;8611.913880861237;8729.738107856774;8943.060978597283;8976.41653292534;566.8356176708709;598.9910151347733;616.3466725271227;623.1525125828869;641.8459569703331;4179.226843034048;4254.808533615995;4264.253755592759;4275.251830929575;4301;67961;69921;80003;115244.21606667405;115273;62574;94992.52503737576;97320.11747430205;97527;99284;55598.44401556013;57926;69195.65402172957;71609.64195179095;85003.14996849952;9615.759606009626;9751.853722194315;9844.114029737359;9914.20686345105;10239.84640230412;48611.75694121507;49995.500044999084;52362.47637523728;52421.544168746084;53009;74125.62937185279;76926;78296;78691;79056.60471697604;12149.75700486003;12443.626691199279;12462;12663.556775512812;12811.679708007374;14151.150930944177;14164.716705666035;14272;14408.85591144075;14708.632284192981;13402.865971340161;13419.530316438877;13469.191848489121;13692.726145477234;13719.725605487634;13498.179942670782;13882.09766365183;13890.444382224598;14071.366788494337;14269.571912842632;11992.64022079339;12882.871171288167;13331.9471672705;13584.592462226148;13756.793648095487;9899.356541824758;10218.54016569271;10433.582656693647;10592;10643.8935610646;10752.892471075502;11027.228094033662;11108.61119860801;11205.271657342246;11265.155113366367 02:48:13 INFO - PROCESS | 26277 | __end_tp_report 02:48:13 INFO - PROCESS | 26277 | __start_cc_report 02:48:13 INFO - PROCESS | 26277 | _x_x_mozilla_cycle_collect,871 02:48:13 INFO - PROCESS | 26277 | __end_cc_report 02:48:13 INFO - PROCESS | 26277 | __startTimestamp1467107293638__endTimestamp 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | ------- Summary: start ------- 02:48:13 INFO - PROCESS | 26277 | Number of tests: 6 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | [#0] dojo.html Cycles:165 Average:5345.83 Median:5536.94 stddev:603.87 (10.9%) stddev-sans-first:578.95 02:48:13 INFO - PROCESS | 26277 | Values: 3079.0 3082.8 3097.2 3112.7 3148.1 5200.6 5207.1 5236.1 5296.3 5329.7 5346.3 5352.1 5399.5 5448.8 5506.8 4850.1 4895.5 4915.4 4937.0 5067.9 4993.4 5008.4 5039.5 5067.2 5076.2 4788.6 4847.0 4850.8 4855.0 4878.6 4865.5 4882.0 4939.7 4945.3 4979.8 4784.4 4914.5 4931.7 4932.0 4943.8 5346.7 5407.6 5426.8 5502.3 5517.9 5811.8 5859.9 5881.3 5889.2 5892.6 5576.9 5708.0 5737.3 5745.7 5749.6 5372.8 5455.6 5465.5 5466.2 5467.6 5940.0 5951.9 5953.3 5957.0 5959.9 5474.4 5586.8 5620.2 5716.6 5730.9 5764.2 5804.7 5819.5 5819.8 5820.1 5708.9 5731.4 5747.4 5751.7 5760.7 5554.7 5717.1 5744.1 5744.9 5756.7 4413.7 4416.0 4416.3 4418.2 4458.5 3933.5 3940.6 3952.9 3982.7 3994.5 5207.7 5305.1 5364.1 5416.5 5419.4 5776.9 5794.8 5795.5 5801.2 5840.2 5465.0 5474.0 5474.8 5479.7 5480.3 4778.7 4882.0 4914.7 4921.8 4934.8 5947.4 5953.6 5955.8 5963.2 5967.0 5607.1 5698.5 5720.3 5732.5 5736.1 5910.9 5966.3 5970.4 5988.6 5988.7 5614.2 5636.9 5645.7 5656.8 5661.5 5564.9 5645.3 5745.7 5751.4 5759.0 5555.0 5599.9 5609.5 5610.6 5659.1 5528.9 5570.2 5578.8 5580.6 5587.9 5352.0 5379.9 5419.1 5497.8 5550.5 5697.7 5713.7 5719.6 5724.3 5726.5 5535.7 5536.9 5539.7 5541.9 5553.1 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | [#1] ext.html Cycles:180 Average:59749.01 Median:225535.50 stddev:122443.76 (54.3%) stddev-sans-first:122706.68 02:48:13 INFO - PROCESS | 26277 | Values: 587.8 625.7 629.2 638.6 647.1 32417.7 35551.0 35571.0 35595.5 43382.3 41635.0 45510.5 45528.0 45611.5 45619.3 8984.1 9133.5 9134.3 9138.3 9138.8 8958.4 9058.5 9058.8 9059.4 9061.5 9021.5 9024.6 9029.1 9058.2 9118.5 8948.9 9071.2 9074.0 9077.3 9082.0 8889.4 8958.5 8981.4 8981.6 8983.1 42593.8 42706.0 43031.0 43049.4 43072.0 3563.7 3659.3 3668.6 3838.6 3989.3 31012.2 33574.3 33793.0 33809.8 34005.8 4296.7 4371.1 4374.4 4387.9 4521.9 346391.0 353274.0 354973.0 355221.0 355585.0 35281.6 36182.3 36266.1 63268.0 64235.7 38048.8 38085.2 38176.4 38203.0 38265.0 14652.3 14731.0 14733.0 14736.8 14741.2 12250.6 12276.1 12277.1 12283.3 12287.8 8591.7 8632.9 8633.9 8717.1 8734.8 3352.5 3365.2 3366.2 3391.3 3409.5 1038.2 1045.2 1047.0 1099.2 1129.6 33120.5 33504.7 33561.3 33683.7 34037.3 1101.9 1145.1 1156.7 1159.3 1229.5 16975.9 17740.2 17872.6 17885.4 17927.8 580418.0 585624.0 587560.0 587669.0 588019.0 59678.4 60973.7 61078.0 61269.1 61377.7 1242.7 1349.1 1367.1 1375.2 1384.9 32421.0 33730.5 33873.7 34204.0 34457.7 51588.0 52026.5 52119.2 52178.0 52202.5 397685.0 410047.0 411015.0 411063.0 411915.0 25328.5 28185.3 28609.4 28736.6 29369.7 47696.3 47729.3 48736.0 49044.5 49112.0 40503.0 41470.6 41648.0 42326.4 43002.0 41024.0 41077.0 41702.8 42160.6 42456.8 40837.8 41502.8 41902.6 42149.8 42218.8 34129.0 36670.8 37130.6 37628.6 37694.4 27693.3 28258.6 28301.9 28435.4 28460.9 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | [#2] jquery.html Cycles:180 Average:28198.47 Median:11991.21 stddev:79023.18 (659.0%) stddev-sans-first:79217.28 02:48:13 INFO - PROCESS | 26277 | Values: 392.3 399.2 399.7 403.7 419.9 14125.6 17456.8 17838.6 19615.3 19630.9 14966.2 15575.8 17074.7 17869.6 18798.0 1776.2 1782.0 1782.3 1787.1 1883.0 4076.1 5635.9 5743.3 5744.8 5925.3 6174.9 6249.3 6284.3 6286.6 6286.7 6157.4 6356.5 6411.1 6428.9 6434.6 5618.7 5646.2 5651.1 5653.7 5671.3 13995.3 16451.5 20549.6 21850.9 21852.3 2223.3 2336.9 2862.5 2930.7 2944.1 9462.1 9920.9 10035.3 10345.8 10408.5 1931.0 1980.7 2020.6 2075.0 2131.5 71270.6 75801.2 76330.0 76766.0 82930.8 10306.5 10413.9 10561.4 10646.8 11199.0 15161.9 15231.4 15239.8 15264.5 15271.7 8010.3 8258.1 8496.5 8526.8 8529.0 7197.7 7449.8 7459.9 7487.5 7539.2 4315.9 4466.3 4555.3 4791.4 4842.2 1861.8 1943.7 1974.1 1983.6 2008.5 913.4 980.8 1000.7 1035.5 1036.0 17686.4 18985.5 19092.7 19313.7 19714.8 950.2 967.9 1006.4 1036.4 1041.3 10347.9 10759.9 10830.7 10850.6 10867.1 471581.0 475468.0 476982.0 480693.0 491424.0 57495.0 93206.5 95528.5 96509.5 96672.5 964.7 989.9 996.2 996.8 1013.3 16821.8 16834.4 16894.3 17076.5 17206.8 41415.8 41510.9 42803.0 42932.8 43042.6 54176.0 56543.4 56624.0 62663.0 63380.2 10939.7 11987.0 12006.7 12177.0 12196.4 12536.7 12812.2 12867.2 13358.8 13714.1 10771.7 10909.0 11372.4 11454.7 11735.0 8167.3 8237.0 11769.8 11793.0 11896.3 8089.4 8151.6 8184.0 8223.3 8344.7 11573.9 11806.2 11860.7 11876.6 12299.8 11644.9 11738.5 11755.0 11825.2 11969.2 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | [#3] mootools.html Cycles:180 Average:5982.92 Median:468.74 stddev:3530.55 (753.2%) stddev-sans-first:3522.98 02:48:13 INFO - PROCESS | 26277 | Values: 1308.3 1449.1 1494.7 1606.0 1760.5 8621.4 8996.7 9020.2 9142.4 9147.3 8841.3 9023.2 9025.3 9026.3 9034.3 2011.2 2274.9 2319.1 2356.4 2364.0 2392.4 2397.8 2398.4 2400.7 2402.7 2289.7 2291.9 2305.2 2306.6 2314.3 1915.4 2164.2 2230.4 2232.0 2233.5 2284.3 2300.2 2320.1 2325.3 2327.0 9174.1 9324.4 9350.9 9353.3 9363.6 5323.8 5449.6 5456.7 5458.6 5468.4 3318.4 3374.8 3438.2 3439.3 3458.3 1099.5 1107.7 1119.0 1121.8 1147.1 12869.4 12899.4 12905.8 12922.7 12937.6 4519.8 4590.2 4709.7 4746.9 4751.7 10795.7 10812.2 10813.5 10821.5 10825.5 5255.2 5287.2 5304.1 5313.0 5316.2 4449.2 4639.7 4754.0 4773.0 4855.8 4025.0 4060.7 4087.4 4092.1 4127.9 1291.4 1309.7 1313.7 1325.4 1332.6 820.7 903.5 923.8 930.5 958.0 5853.3 5973.9 6000.8 6121.6 6221.7 463.5 467.5 469.9 470.0 481.6 4138.9 4175.8 4196.0 4219.3 4224.6 11191.9 11562.2 11578.0 11674.6 11694.8 11497.3 11555.8 11562.6 11564.0 11568.0 8099.7 8387.7 8434.2 8465.9 8658.9 6070.3 6277.7 6333.2 6374.4 6398.1 10506.0 10676.6 10789.6 10798.6 10912.9 10680.4 10967.6 11001.9 11095.1 11102.3 7402.8 8115.8 8151.1 8322.9 8437.6 8504.8 8820.2 8868.6 8902.6 8912.1 7584.1 7851.0 7919.4 7931.2 8006.0 7779.0 7781.2 7785.8 7815.9 7841.7 7311.0 7368.4 7447.4 7465.5 7468.1 5080.4 5116.7 5159.9 5232.8 5248.2 5095.5 5163.1 5178.9 5242.8 5280.3 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | [#4] prototype.html Cycles:180 Average:4650.85 Median:5317.76 stddev:1365.20 (25.7%) stddev-sans-first:1329.92 02:48:13 INFO - PROCESS | 26277 | Values: 328.1 333.7 340.6 341.8 342.2 5286.6 5304.1 5320.9 5334.9 5365.8 5222.9 5245.7 5257.7 5282.7 5287.9 3956.2 4002.4 4161.6 4194.6 4224.4 4119.2 4128.0 4137.2 4155.8 4160.4 3995.1 4148.9 4150.9 4156.7 4171.5 3963.9 4077.2 4081.9 4082.3 4091.8 3646.3 3651.9 3658.6 3660.1 3672.4 5053.8 5083.9 5087.2 5107.6 5114.2 4499.3 4678.7 4679.3 4691.0 4709.7 5337.4 5349.1 5353.1 5416.3 5426.7 3985.4 3997.4 4011.2 4036.8 4049.3 5356.9 5646.2 5666.3 5669.7 5690.4 4008.0 4010.8 4021.1 4034.1 4042.6 4088.8 4092.8 4108.2 4117.7 4133.5 4445.4 4640.5 4681.6 4721.7 4724.7 5487.8 5507.9 5508.1 5508.6 5536.5 1399.9 1426.6 1427.8 1428.3 1430.8 902.1 912.5 921.6 932.2 973.9 5243.7 5297.0 5310.3 5314.6 5327.9 5557.5 5562.7 5575.5 5578.0 5589.8 5058.5 5237.6 5245.3 5262.8 5355.7 2945.5 2963.2 2979.3 2990.0 2991.8 5843.6 5859.8 5865.2 5871.9 5876.5 5528.4 5764.9 5796.7 5812.8 5827.0 5904.4 5936.2 5944.3 5951.7 6014.2 5421.6 5703.9 5726.5 5762.7 5765.3 5517.2 5560.2 5562.3 5652.6 5659.3 5837.7 5868.0 5927.8 5993.0 6008.9 4008.3 4099.9 4104.0 4106.3 4118.8 5669.1 5674.6 5738.6 5756.8 5777.6 5383.6 5432.7 5544.0 5557.2 5626.9 5512.3 5517.4 5518.4 5518.8 5543.7 5269.3 5474.3 5475.7 5514.7 5520.0 5472.1 5497.5 5511.5 5528.8 5547.9 5375.6 5404.5 5414.8 5429.7 5437.9 02:48:13 INFO - PROCESS | 26277 | 02:48:13 INFO - PROCESS | 26277 | [#5] yui.html Cycles:180 Average:19096.43 Median:4711.97 stddev:26379.25 (559.8%) stddev-sans-first:26417.22 02:48:13 INFO - PROCESS | 26277 | Values: 733.6 771.6 772.5 820.7 822.7 13177.2 13747.6 13806.5 13830.9 13931.4 14556.4 14762.9 15044.3 15057.2 15062.3 777.1 786.1 793.4 793.9 794.1 657.6 761.6 790.0 799.0 800.4 838.0 841.0 841.4 841.8 841.8 828.3 828.7 829.0 829.0 829.5 508.0 596.3 611.2 611.3 612.1 14900.1 14918.8 14935.9 14977.3 15017.5 13703.2 14191.7 14216.1 14541.0 14542.2 11896.4 12362.0 12760.7 12782.5 12892.7 4431.2 4526.9 4532.4 4532.4 4614.6 69416.3 69506.7 69562.7 69611.3 69633.3 10580.8 10686.9 10754.2 10917.5 11133.6 19477.7 20484.3 20506.2 21142.5 21184.4 8822.9 8883.6 8891.8 8897.0 8900.6 4548.6 4605.6 4670.8 4688.9 4735.0 3367.2 3462.2 3482.9 3490.0 3490.1 603.4 609.4 614.9 622.9 625.1 514.5 528.0 535.8 576.8 660.0 8592.7 8611.9 8729.7 8943.1 8976.4 566.8 599.0 616.3 623.2 641.8 4179.2 4254.8 4264.3 4275.3 4301.0 67961.0 69921.0 80003.0 115244.2 115273.0 62574.0 94992.5 97320.1 97527.0 99284.0 55598.4 57926.0 69195.7 71609.6 85003.1 9615.8 9751.9 9844.1 9914.2 10239.8 48611.8 49995.5 52362.5 52421.5 53009.0 74125.6 76926.0 78296.0 78691.0 79056.6 12149.8 12443.6 12462.0 12663.6 12811.7 14151.2 14164.7 14272.0 14408.9 14708.6 13402.9 13419.5 13469.2 13692.7 13719.7 13498.2 13882.1 13890.4 14071.4 14269.6 11992.6 12882.9 13331.9 13584.6 13756.8 9899.4 10218.5 10433.6 10592.0 10643.9 10752.9 11027.2 11108.6 11205.3 11265.2 02:48:13 INFO - PROCESS | 26277 | -------- Summary: end -------- 02:48:13 INFO - PROCESS | 26277 | 02:48:14 INFO - TEST-INFO | 26277: exit 0 02:48:14 INFO - TEST-OK | dromaeo_css | took 1114088ms 02:48:14 INFO - TEST-START | kraken 02:48:14 INFO - operating with platform_type : linux_ 02:48:14 INFO - Initialising browser for kraken test... 02:48:14 INFO - TEST-INFO | started process 26460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkU8pP1/profile http://localhost:40303/getInfo.html) 02:48:18 INFO - PROCESS | 26460 | __metrics Screen width/height:1600/1200 02:48:18 INFO - PROCESS | 26460 | colorDepth:24 02:48:18 INFO - PROCESS | 26460 | Browser inner width/height: 1024/697 02:48:18 INFO - PROCESS | 26460 | __metrics 02:48:19 INFO - PROCESS | 26460 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:48:20 INFO - TEST-INFO | 26460: exit 0 02:48:20 INFO - Browser initialized. 02:48:20 INFO - Running cycle 1/1 for kraken test... 02:48:20 INFO - TEST-INFO | started process 26546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkU8pP1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:32 INFO - PROCESS | 26546 | RSS: Main: 156729344 02:48:32 INFO - PROCESS | 26546 | 02:48:34 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40303/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:35 INFO - PROCESS | 26546 | RSS: Main: 214638592 02:48:35 INFO - PROCESS | 26546 | 02:48:38 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40303/tests/kraken/driver.html?testName=audio-dft) 02:48:38 INFO - PROCESS | 26546 | RSS: Main: 203304960 02:48:38 INFO - PROCESS | 26546 | 02:48:41 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40303/tests/kraken/driver.html?testName=audio-fft) 02:48:42 INFO - PROCESS | 26546 | RSS: Main: 268312576 02:48:42 INFO - PROCESS | 26546 | 02:48:44 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40303/tests/kraken/driver.html?testName=audio-oscillator) 02:48:45 INFO - PROCESS | 26546 | RSS: Main: 180068352 02:48:45 INFO - PROCESS | 26546 | 02:48:47 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:47 INFO - PROCESS | 26546 | RSS: Main: 184016896 02:48:47 INFO - PROCESS | 26546 | 02:48:50 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40303/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:51 INFO - PROCESS | 26546 | RSS: Main: 219598848 02:48:51 INFO - PROCESS | 26546 | 02:48:55 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40303/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:55 INFO - PROCESS | 26546 | RSS: Main: 220315648 02:48:55 INFO - PROCESS | 26546 | 02:48:58 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40303/tests/kraken/driver.html?testName=json-parse-financial) 02:48:59 INFO - PROCESS | 26546 | RSS: Main: 220979200 02:48:59 INFO - PROCESS | 26546 | 02:49:00 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:49:01 INFO - PROCESS | 26546 | RSS: Main: 207175680 02:49:01 INFO - PROCESS | 26546 | 02:49:02 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:49:03 INFO - PROCESS | 26546 | RSS: Main: 212324352 02:49:03 INFO - PROCESS | 26546 | 02:49:05 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:49:06 INFO - PROCESS | 26546 | RSS: Main: 219754496 02:49:06 INFO - PROCESS | 26546 | 02:49:08 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:49:09 INFO - PROCESS | 26546 | RSS: Main: 221667328 02:49:09 INFO - PROCESS | 26546 | 02:49:12 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:49:12 INFO - PROCESS | 26546 | RSS: Main: 222404608 02:49:12 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:40303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40303/tests/kraken/driver.html?testName=ai-astar) 02:49:14 INFO - PROCESS | 26546 | RSS: Main: 265973760 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | __start_tp_report 02:49:14 INFO - PROCESS | 26546 | _x_x_mozilla_page_load 02:49:14 INFO - PROCESS | 26546 | _x_x_mozilla_page_load_details 02:49:14 INFO - PROCESS | 26546 | |i|pagename|runs| 02:49:14 INFO - PROCESS | 26546 | |0;ai-astar;99;111;109;109;110;108;108;108;108;107 02:49:14 INFO - PROCESS | 26546 | |1;audio-beat-detection;152;125;126;187;132;128;157;128;166;131 02:49:14 INFO - PROCESS | 26546 | |2;audio-dft;161;162;161;161;162;161;167;161;160;161 02:49:14 INFO - PROCESS | 26546 | |3;audio-fft;76;74;75;121;76;76;74;74;102;76 02:49:14 INFO - PROCESS | 26546 | |4;audio-oscillator;86;85;129;87;86;85;115;85;85;130 02:49:14 INFO - PROCESS | 26546 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;116;117;116 02:49:14 INFO - PROCESS | 26546 | |6;imaging-darkroom;145;146;146;146;146;145;147;146;146;145 02:49:14 INFO - PROCESS | 26546 | |7;imaging-desaturate;94;95;95;95;95;94;96;95;95;95 02:49:14 INFO - PROCESS | 26546 | |8;json-parse-financial;56;56;57;56;56;57;59;57;55;57 02:49:14 INFO - PROCESS | 26546 | |9;json-stringify-tinderbox;61;60;60;60;61;61;60;61;61;62 02:49:14 INFO - PROCESS | 26546 | |10;stanford-crypto-aes;80;78;82;82;77;80;78;80;93;80 02:49:14 INFO - PROCESS | 26546 | |11;stanford-crypto-ccm;125;120;120;128;121;122;116;133;127;121 02:49:14 INFO - PROCESS | 26546 | |12;stanford-crypto-pbkdf2;160;168;164;168;160;157;157;161;158;161 02:49:14 INFO - PROCESS | 26546 | |13;stanford-crypto-sha256-iterative;66;62;63;61;66;62;61;62;61;62 02:49:14 INFO - PROCESS | 26546 | __end_tp_report 02:49:14 INFO - PROCESS | 26546 | __start_cc_report 02:49:14 INFO - PROCESS | 26546 | _x_x_mozilla_cycle_collect,1668 02:49:14 INFO - PROCESS | 26546 | __end_cc_report 02:49:14 INFO - PROCESS | 26546 | __startTimestamp1467107354664__endTimestamp 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | ------- Summary: start ------- 02:49:14 INFO - PROCESS | 26546 | Number of tests: 14 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:3.27 (3.0%) stddev-sans-first:1.22 02:49:14 INFO - PROCESS | 26546 | Values: 99.0 111.0 109.0 109.0 110.0 108.0 108.0 108.0 108.0 107.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:142.00 stddev:21.26 (15.0%) stddev-sans-first:22.31 02:49:14 INFO - PROCESS | 26546 | Values: 152.0 125.0 126.0 187.0 132.0 128.0 157.0 128.0 166.0 131.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:1.95 (1.2%) stddev-sans-first:2.05 02:49:14 INFO - PROCESS | 26546 | Values: 161.0 162.0 161.0 161.0 162.0 161.0 167.0 161.0 160.0 161.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:16.00 (21.2%) stddev-sans-first:16.80 02:49:14 INFO - PROCESS | 26546 | Values: 76.0 74.0 75.0 121.0 76.0 76.0 74.0 74.0 102.0 76.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.00 stddev:19.30 (22.7%) stddev-sans-first:20.04 02:49:14 INFO - PROCESS | 26546 | Values: 86.0 85.0 129.0 87.0 86.0 85.0 115.0 85.0 85.0 130.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:49:14 INFO - PROCESS | 26546 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 02:49:14 INFO - PROCESS | 26546 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 02:49:14 INFO - PROCESS | 26546 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.07 (1.9%) stddev-sans-first:1.12 02:49:14 INFO - PROCESS | 26546 | Values: 56.0 56.0 57.0 56.0 56.0 57.0 59.0 57.0 55.0 57.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:49:14 INFO - PROCESS | 26546 | Values: 61.0 60.0 60.0 60.0 61.0 61.0 60.0 61.0 61.0 62.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:4.52 (5.7%) stddev-sans-first:4.78 02:49:14 INFO - PROCESS | 26546 | Values: 80.0 78.0 82.0 82.0 77.0 80.0 78.0 80.0 93.0 80.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:123.50 stddev:4.95 (4.0%) stddev-sans-first:5.21 02:49:14 INFO - PROCESS | 26546 | Values: 125.0 120.0 120.0 128.0 121.0 122.0 116.0 133.0 127.0 121.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.00 stddev:4.06 (2.5%) stddev-sans-first:4.28 02:49:14 INFO - PROCESS | 26546 | Values: 160.0 168.0 164.0 168.0 160.0 157.0 157.0 161.0 158.0 161.0 02:49:14 INFO - PROCESS | 26546 | 02:49:14 INFO - PROCESS | 26546 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:1.90 (3.1%) stddev-sans-first:1.56 02:49:14 INFO - PROCESS | 26546 | Values: 66.0 62.0 63.0 61.0 66.0 62.0 61.0 62.0 61.0 62.0 02:49:14 INFO - PROCESS | 26546 | -------- Summary: end -------- 02:49:14 INFO - PROCESS | 26546 | 02:49:15 INFO - TEST-INFO | 26546: exit 0 02:49:15 INFO - TEST-OK | kraken | took 61188ms 02:49:15 INFO - SUITE-END | took 1175s 02:49:15 INFO - Completed test suite (00:19:35) 02:49:15 INFO - javascript benchmark 02:49:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.0, 3082.7996180248283, 3097.1792474994118, 3112.735417489513, 3148.102790704648, 5200.6099542534275, 5207.140821764414, 5236.057509648262, 5296.285001524793, 5329.733513324328, 5346.251524786533, 5352.143657014878, 5399.487048730374, 5448.7548060337285, 5506.779728810853, 4850.078485087822, 4895.534924182197, 4915.3855768029, 4936.975315123419, 5067.93573349597, 4993.400791904976, 5008.449070602231, 5039.521245481692, 5067.214581739836, 5076.187809950408, 4788.592969597588, 4846.975765121187, 4850.757462126897, 4854.951450485521, 4878.634102442314, 4865.5134486551415, 4882.0, 4939.703617782909, 4945.307656928033, 4979.775910084055, 4784.40194975628, 4914.4839791821705, 4931.65478416511, 4931.975340123312, 4943.802247910079, 5346.652467589594, 5407.594430417695, 5426.8371948841595, 5502.339719233718, 5517.917231241535, 5811.82564523065, 5859.941400585983, 5881.264841894763, 5889.204957330749, 5892.616979896293, 5576.944230557724, 5708.0, 5737.311522617271, 5745.683987380692, 5749.59752817303, 5372.811951581676, 5455.618106732531, 5465.453454654582, 5466.180072989084, 5467.5625949923915, 5940.049592065248, 5951.940480595225, 5953.28560572734, 5956.970215148983, 5959.880802384015, 5474.42518535556, 5586.804461843816, 5620.241267428926, 5716.628419152742, 5730.914036289459, 5764.193012978187, 5804.709764511842, 5819.53443724501, 5819.82540523785, 5820.068788993825, 5708.942910570924, 5731.426857314235, 5747.3677895431465, 5751.654900705971, 5760.74076666551, 5554.666719996813, 5717.142428635738, 5744.052231381859, 5744.885102298014, 5756.683382414008, 4413.691041627119, 4416.0, 4416.271315232951, 4418.226810308183, 4458.464984201916, 3933.527976642764, 3940.625640564142, 3952.9209415811524, 3982.7012974026484, 3994.46074779901, 5207.713575753294, 5305.124654431976, 5364.088105022156, 5416.51251387377, 5419.376771671229, 5776.855578610484, 5794.82615521535, 5795.507381872504, 5801.216835727208, 5840.240768700127, 5464.972675136599, 5473.972630136824, 5474.781008759605, 5479.671219726829, 5480.314960629921, 4778.737169455713, 4882.0, 4914.72968986702, 4921.827736029293, 4934.8026078957155, 5947.37552556984, 5953.613015154001, 5955.7617695292565, 5963.224780778471, 5967.0, 5607.074832652566, 5698.544116470755, 5720.2849643794525, 5732.541396688338, 5736.139579063007, 5910.940890591211, 5966.343702192842, 5970.402959703995, 5988.5508586855285, 5988.700564971821, 5614.185943038318, 5636.88726225465, 5645.661260324394, 5656.8020119295625, 5661.490465858093, 5564.860878478071, 5645.322561292671, 5745.6552606843725, 5751.3673495916255, 5759.049756790083, 5555.0, 5599.888002239851, 5609.49514543693, 5610.6072574921, 5659.066254068197, 5528.86177845541, 5570.164475328733, 5578.832635020955, 5580.609357344947, 5587.944120558905, 5352.0, 5379.946200537945, 5419.078756611464, 5497.835064948058, 5550.52820510245, 5697.7436015380235, 5713.742881570256, 5719.599628025998, 5724.313082430135, 5726.513246374105, 5535.667859928417, 5536.944630553643, 5539.695316757617, 5541.861453463695, 5553.111502159635], "value": 5305.202858684325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7737071227576, 625.6683957502526, 629.2291942370595, 638.6295948349955, 647.1005302629345, 32417.67582324176, 35551.0, 35571.0, 35595.466068008966, 43382.349264761055, 41635.0, 45510.54489455104, 45528.0, 45611.54388456123, 45619.315710264375, 8984.146506081912, 9133.497657628828, 9134.269258459308, 9138.268938484938, 9138.817223655524, 8958.37291389603, 9058.547072646374, 9058.818823623524, 9059.365844390863, 9061.50161741104, 9021.458712477272, 9024.593893274818, 9029.142231488031, 9058.184763371295, 9118.452892826419, 8948.881389826272, 9071.228945539637, 9073.954630226806, 9077.273818094536, 9082.0, 8889.422187557853, 8958.462492250486, 8981.371304008722, 8981.595828187747, 8983.146601072953, 42593.78703106496, 42706.0, 43031.0, 43049.35425968613, 43072.0, 3563.6614521620404, 3659.3230252403123, 3668.575518969206, 3838.5777564467885, 3989.3018721723583, 31012.224694382596, 33574.328513429595, 33793.0, 33809.83095084533, 34005.82997085024, 4296.720713153666, 4371.060222052242, 4374.387585737967, 4387.934180987288, 4521.909561808746, 346391.0, 353274.0, 354973.0, 355221.0, 355585.0, 35281.64718352835, 36182.27635447329, 36266.09334766599, 63268.0, 64235.678821605594, 38048.809755951595, 38085.23829523394, 38176.427353589715, 38203.0, 38265.0, 14652.267386630625, 14731.0, 14733.04235224707, 14736.778948315783, 14741.1892345922, 12250.632481025583, 12276.079294052803, 12277.079219058607, 12283.263004219776, 12287.815682764765, 8591.6992905248, 8632.91367086321, 8633.870491942625, 8717.084706105894, 8734.825303493895, 3352.5138854866395, 3365.22599802042, 3366.1584603849037, 3391.2878295557716, 3409.4544872820725, 1038.1953985661023, 1045.2474218562622, 1047.000114890278, 1099.2085698297212, 1129.6102844518628, 33120.50319245213, 33504.66495335064, 33561.32877342439, 33683.66316336854, 34037.31925361479, 1101.8787933327328, 1145.1010956399186, 1156.6587856582328, 1159.3275899977994, 1229.4774720743649, 16975.915120424317, 17740.20169092368, 17872.642547148986, 17885.374011909782, 17927.820721792876, 580418.0, 585624.0, 587560.0, 587669.0, 588019.0, 59678.40321596815, 60973.69513152406, 61078.0, 61269.08096378469, 61377.69311153416, 1242.7017515796324, 1349.089364678838, 1367.118208755367, 1375.1817668487433, 1384.8753612174953, 32421.0, 33730.494042589875, 33873.661263388036, 34204.0, 34457.655423445445, 51588.0, 52026.47973520216, 52119.218211726096, 52178.0, 52202.477975219765, 397685.0, 410047.0, 411015.0, 411063.0, 411915.0, 25328.493430131664, 28185.295367615974, 28609.42781144407, 28736.568951465328, 29369.7063029367, 47696.28455573239, 47729.28406073842, 48736.0, 49044.50955490399, 49112.0, 40503.0, 41470.58529414788, 41648.0, 42326.36510452407, 43002.0, 41024.0, 41077.0, 41702.79148604238, 42160.57839421566, 42456.78771606122, 40837.795811020755, 41502.792486037375, 41902.58097418987, 42149.789251053546, 42218.78890605527, 34129.0, 36670.84542426039, 37130.628693712715, 37628.623713762514, 37694.434583481816, 27693.307667307672, 28258.576121357786, 28301.858490707415, 28435.43129137447, 28460.857695711387], "value": 19079.70455842935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.3232424068481, 399.19362886968344, 399.6542990313378, 403.67907513526745, 419.9013231890505, 14125.576232713009, 17456.825431745678, 17838.64322713545, 19615.313464028743, 19630.90184549077, 14966.17686027268, 15575.766363504528, 17074.658506829855, 17869.57043436525, 18798.0, 1776.2273411066162, 1782.037699642198, 1782.2959930827315, 1787.1421717575572, 1882.992598959557, 4076.082881351702, 5635.887282254353, 5743.339515955677, 5744.827655170351, 5925.31858836235, 6174.938250617503, 6249.3438188990185, 6284.277308109557, 6286.591371560857, 6286.748530058792, 6157.445829875311, 6356.491480681558, 6411.1024456576115, 6428.871422571522, 6434.5843914338775, 5618.747156377973, 5646.20953066571, 5651.124075768263, 5653.745581448845, 5671.347795003545, 13995.30023498821, 16451.506454806375, 20549.5890082199, 21850.89074554633, 21852.344429666977, 2223.3330000999636, 2336.9298921032396, 2862.527682932314, 2930.7362337389736, 2944.05790147153, 9462.148406643435, 9920.90079099207, 10035.29752917296, 10345.793084138275, 10408.47957602117, 1930.9710354344695, 1980.6731889238258, 2020.6261841559358, 2074.979250207494, 2131.520407908208, 71270.64364678196, 75801.24198757997, 76330.0, 76766.0, 82930.75603866007, 10306.484675766182, 10413.895861041445, 10561.366318020944, 10646.840297395545, 11199.048080913051, 15161.924190378977, 15231.390744370323, 15239.847601523843, 15264.465743698916, 15271.694566108616, 8010.279074883289, 8258.132896045829, 8496.490210587384, 8526.829463410697, 8529.0, 7197.712091516385, 7449.839546531553, 7459.888101678479, 7487.47587668858, 7539.208383119693, 4315.913681726411, 4466.285394336891, 4555.316702494652, 4791.353167322437, 4842.249451335048, 1861.8417434518217, 1943.737595424628, 1974.052454821665, 1983.5636160044767, 2008.4677560446494, 913.3789023463976, 980.7548112971757, 1000.7448100734412, 1035.534009695625, 1036.0054347826172, 17686.380976665754, 18985.525361866064, 19092.71360929587, 19313.710294345598, 19714.802851971584, 950.1970834644715, 967.8983706710694, 1006.3609607899036, 1036.4196050211906, 1041.2815157541272, 10347.896521034843, 10759.89240107589, 10830.67507974762, 10850.620228291971, 10867.076298514557, 471581.0, 475468.0, 476982.0, 480693.0, 491424.0, 57495.0, 93206.53396733108, 95528.52235738916, 96509.51745241228, 96672.51663741637, 964.7250533597891, 989.9406035637885, 996.1930836022844, 996.7707427291764, 1013.3261381181579, 16821.831781682515, 16834.410795622094, 16894.324227030782, 17076.487705368858, 17206.82793172102, 41415.7929210352, 41510.886683498255, 42803.0, 42932.78533607312, 43042.56957430386, 54176.0, 56543.43456565381, 56624.0, 62663.0, 63380.16211114185, 10939.704027872518, 11987.0, 12006.699832504257, 12177.0, 12196.390180491117, 12536.686582835502, 12812.167209131376, 12867.22796632205, 13358.799618005543, 13714.108582942476, 10771.676849694522, 10909.0, 11372.37451940118, 11454.713632159262, 11735.0, 8167.346612270885, 8236.958815206126, 11769.764604708029, 11793.0, 11896.345700986529, 8089.393295502979, 8151.5924203790755, 8184.0, 8223.342132629256, 8344.749657510285, 11573.942130289295, 11806.173567850168, 11860.703482413008, 11876.584319548774, 12299.75400492003, 11644.88355116438, 11738.530458781554, 11755.0, 11825.231359961575, 11969.16215864916], "value": 8880.858021211357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.3196737696403, 1449.1087980891753, 1494.7384207763641, 1605.9598510037256, 1760.5158581390108, 8621.396502244837, 8996.68511602094, 9020.188183063523, 9142.405743626676, 9147.268218542516, 8841.292696584274, 9023.23302519285, 9025.323100767453, 9026.27789776818, 9034.322425818056, 2011.2256781139295, 2274.863508189514, 2319.083961835074, 2356.434455730621, 2364.042562762084, 2392.425817803732, 2397.760223977597, 2398.388410955204, 2400.6519054737055, 2402.723686776017, 2289.748127705959, 2291.8510296830736, 2305.170138750049, 2306.630939049752, 2314.2941402872116, 1915.4062240705357, 2164.177612507237, 2230.408941630469, 2232.0402227042364, 2233.497463070796, 2284.326123793485, 2300.2179259052004, 2320.083566991046, 2325.3489023073566, 2326.999390262187, 9174.08259174084, 9324.440533568008, 9350.90649093507, 9353.251739860794, 9363.62545498186, 5323.813666521692, 5449.618526703132, 5456.672599644034, 5458.645188062763, 5468.398476167618, 3318.386098571772, 3374.780639258465, 3438.157651375404, 3439.2949445363643, 3458.2910503347007, 1099.5052226498028, 1107.6787731557838, 1118.972025699356, 1121.7532142928542, 1147.0594112827484, 12869.4208760606, 12899.419526121346, 12905.806412903814, 12922.676933076655, 12937.611871643865, 4519.841805536857, 4590.196715574828, 4709.670323077352, 4746.905061898743, 4751.691140075884, 10795.676129716121, 10812.243142979916, 10813.513391897226, 10821.513031913582, 10825.458727063615, 5255.237990491358, 5287.180487024518, 5304.071787437183, 5313.017091838023, 5316.202569614588, 4449.243628583149, 4639.744814035261, 4753.976230118897, 4773.0453909218295, 4855.757212139379, 4024.9697195564713, 4060.675145988314, 4087.448194493705, 4092.1201941582704, 4127.8968025799595, 1291.373683763374, 1309.7118633900527, 1313.6650154210615, 1325.3505782166862, 1332.580237225271, 820.7250571058643, 903.4895284164426, 923.8383282925461, 930.5161316115582, 957.9808403831885, 5853.297604287428, 5973.910391344133, 6000.819975400745, 6121.632702037892, 6221.657808820558, 463.4832162139258, 467.5441444591496, 469.94125734283216, 469.9553542413465, 481.55456203012074, 4138.896527586834, 4175.812088456027, 4195.958040419618, 4219.303814870574, 4224.577542245751, 11191.888081119247, 11562.190646654653, 11578.0, 11674.591389301333, 11694.824577631342, 11497.252678575866, 11555.826662600068, 11562.595309164139, 11564.0, 11568.0, 8099.716509922242, 8387.664493420194, 8434.15658434164, 8465.873011904827, 8658.913410865936, 6070.332263450929, 6277.686115694106, 6333.1766870306565, 6374.394432528902, 6398.104265402754, 10506.0, 10676.572937082741, 10789.62236321725, 10798.56805727762, 10912.890871091187, 10680.412577308012, 10967.561297548009, 11001.889981100087, 11095.11239100886, 11102.2783519071, 7402.814929626802, 8115.837683246184, 8151.1441298662785, 8322.916770832215, 8437.62030708632, 8504.787380315542, 8820.2061814437, 8868.556572171494, 8902.59938302791, 8912.108789121035, 7584.127825300161, 7851.0, 7919.445638805229, 7931.2068793120225, 8006.039275287003, 7778.961105194438, 7781.182975787461, 7785.844283114419, 7815.882761758465, 7841.686332546634, 7311.049563556704, 7368.410527157922, 7447.404207663482, 7465.514741541782, 7468.066491688539, 5080.415752188545, 5116.692998420107, 5159.896802064013, 5232.843014709565, 5248.212768084818, 5095.541401273903, 5163.070647283525, 5178.922316165336, 5242.76407561653, 5280.287161233185], "value": 4641.731145704957, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.1157281127361, 333.65133435559835, 340.5810852651238, 341.7812599936043, 342.245349005443, 5286.603504737141, 5304.098303288441, 5320.9467905320935, 5334.919976200355, 5365.826840129749, 5222.9477705222935, 5245.659032162906, 5257.737113144347, 5282.709450980205, 5287.947120528794, 3956.248312820555, 4002.4196491508715, 4161.604647558477, 4194.622483976442, 4224.366345048252, 4119.196756632443, 4128.0, 4137.1725654869, 4155.838963738854, 4160.4383408239955, 3995.0823604669777, 4148.854790082332, 4150.937735933963, 4156.688248381369, 4171.541130475645, 3963.8612648557305, 4077.245709543744, 4081.897887570369, 4082.3060079786505, 4091.7954102294766, 3646.3072016316814, 3651.908702282438, 3658.579263384718, 3660.103274697716, 3672.4307732301536, 5053.823116190915, 5083.949160508385, 5087.186050231982, 5107.565856902131, 5114.156164232897, 4499.257622492285, 4678.69588476748, 4679.274712419547, 4690.9530904690855, 4709.693869898446, 5337.439568845293, 5349.117395629716, 5353.116735738598, 5416.295881535415, 5426.720777273555, 3985.4021896715435, 3997.360422332413, 4011.1576568920564, 4036.8183431745642, 4049.311617025113, 5356.91964620531, 5646.2377579027125, 5666.263385759866, 5669.716514174274, 5690.374058853523, 4008.0, 4010.7593544386846, 4021.1153546219784, 4034.11249525104, 4042.555318914917, 4088.7920522917884, 4092.795360232036, 4108.157827645326, 4117.732347397409, 4133.4626498555, 4445.377647129404, 4640.535946405333, 4681.625469962395, 4721.669483136147, 4724.692894961817, 5487.780488780404, 5507.917381239285, 5508.063629183049, 5508.614396992172, 5536.501714845684, 1399.8670126337981, 1426.5934208750457, 1427.750143724844, 1428.264443811438, 1430.7853821926794, 902.1114202510522, 912.4753266871576, 921.576075005505, 932.2076235200161, 973.9415635061919, 5243.685378877203, 5297.0, 5310.256564081032, 5314.5748340132695, 5327.946720532823, 5557.499825015768, 5562.666240025612, 5575.498205161555, 5577.995960727027, 5589.80435684749, 5058.544730974157, 5237.6333656643665, 5245.291885595396, 5262.7631756571045, 5355.732213389315, 2945.4550908082074, 2963.2147480917574, 2979.284971606842, 2989.9834056420486, 2991.760659147263, 5843.620164689281, 5859.765609375662, 5865.20819689345, 5871.911921321183, 5876.500497457764, 5528.408641291411, 5764.942350576524, 5796.739146738322, 5812.796552120655, 5827.009408400582, 5904.439078287556, 5936.198613187251, 5944.256967879015, 5951.672658003851, 6014.248218972629, 5421.62048656606, 5703.914441283467, 5726.484616384545, 5762.683052432157, 5765.250517432707, 5517.227588137584, 5560.221568980265, 5562.332520097614, 5652.604317697722, 5659.349174844946, 5837.708114594168, 5867.970660146672, 5927.8221653350465, 5993.0, 6008.87982240344, 4008.2584721826556, 4099.85650502231, 4104.0, 4106.301928672193, 4118.8352465901025, 5669.149627555735, 5674.631148975303, 5738.626989245853, 5756.791073874533, 5777.595568310178, 5383.596230282823, 5432.701201433959, 5543.972280138573, 5557.194206839905, 5626.887462250814, 5512.283403157564, 5517.399954013452, 5518.392976772632, 5518.806841760519, 5543.722813859372, 5269.262303277621, 5474.288342515448, 5475.672839043311, 5514.6691198528215, 5520.012795393574, 5472.112121318139, 5497.532709719719, 5511.5315198207, 5528.834134975958, 5547.8890422190525, 5375.56995440356, 5404.54061404785, 5414.783408663609, 5429.701366424884, 5437.945620543744], "value": 4217.0349467111955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.6038539188838, 771.5987686403071, 772.470857462638, 820.7270711230791, 822.7038266224155, 13177.209367437948, 13747.587572372844, 13806.516771912986, 13830.930845345785, 13931.442742290308, 14556.417743290256, 14762.852371476281, 15044.323005464754, 15057.24713764313, 15062.322195501201, 777.1451403456209, 786.1234723283526, 793.4406243598278, 793.8531371696225, 794.1343935110729, 657.5594351784292, 761.5887420792793, 790.0164295452141, 798.9800254993643, 800.4436916343144, 838.0195171649185, 841.045413455726, 841.4194205997873, 841.7685136587427, 841.7853447370912, 828.2587084559345, 828.747232094211, 829.0134739659785, 829.0134739659816, 829.5064436660177, 507.959363250939, 596.272547492059, 611.2084850119106, 611.2817439508559, 612.0604871522237, 14900.105993640416, 14918.776218356734, 14935.925320373328, 14977.326020329112, 15017.474388396353, 13703.246321452316, 14191.716165676731, 14216.14703117806, 14541.0, 14542.200178990151, 11896.363945204412, 12361.982574600275, 12760.680982975407, 12782.488700451971, 12892.742145157139, 4431.246688063037, 4526.864194074183, 4532.410786597721, 4532.4334458192725, 4614.584687378152, 69416.3058369415, 69506.65246673785, 69562.65218673875, 69611.30388696099, 69633.30366696318, 10580.841287380696, 10686.946565267124, 10754.247202695737, 10917.508712107974, 11133.610323638633, 19477.707834382494, 20484.283050093472, 20506.179752810018, 21142.47143821386, 21184.364469065953, 8822.911770882338, 8883.600237989305, 8891.777705557413, 8896.955515222382, 8900.554972251492, 4548.647873108832, 4605.631549476101, 4670.813167473331, 4688.929666055012, 4735.005648813719, 3367.1582104473882, 3462.23830757233, 3482.9477557836653, 3489.9825500872334, 3490.110021944439, 603.4067130239414, 609.4149616368247, 614.9108379285068, 622.9314775374705, 625.08425157145, 514.5086442447529, 527.9678229062174, 535.8499620106377, 576.7519966414482, 659.980200593983, 8592.65629374818, 8611.913880861237, 8729.738107856774, 8943.060978597283, 8976.41653292534, 566.8356176708709, 598.9910151347733, 616.3466725271227, 623.1525125828869, 641.8459569703331, 4179.226843034048, 4254.808533615995, 4264.253755592759, 4275.251830929575, 4301.0, 67961.0, 69921.0, 80003.0, 115244.21606667405, 115273.0, 62574.0, 94992.52503737576, 97320.11747430205, 97527.0, 99284.0, 55598.44401556013, 57926.0, 69195.65402172957, 71609.64195179095, 85003.14996849952, 9615.759606009626, 9751.853722194315, 9844.114029737359, 9914.20686345105, 10239.84640230412, 48611.75694121507, 49995.500044999084, 52362.47637523728, 52421.544168746084, 53009.0, 74125.62937185279, 76926.0, 78296.0, 78691.0, 79056.60471697604, 12149.75700486003, 12443.626691199279, 12462.0, 12663.556775512812, 12811.679708007374, 14151.150930944177, 14164.716705666035, 14272.0, 14408.85591144075, 14708.632284192981, 13402.865971340161, 13419.530316438877, 13469.191848489121, 13692.726145477234, 13719.725605487634, 13498.179942670782, 13882.09766365183, 13890.444382224598, 14071.366788494337, 14269.571912842632, 11992.64022079339, 12882.871171288167, 13331.9471672705, 13584.592462226148, 13756.793648095487, 9899.356541824758, 10218.54016569271, 10433.582656693647, 10592.0, 10643.8935610646, 10752.892471075502, 11027.228094033662, 11108.61119860801, 11205.271657342246, 11265.155113366367], "value": 7245.35923705006, "unit": "score"}], "name": "dromaeo_css", "value": 7094.466304203031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 109.0, 109.0, 110.0, 108.0, 108.0, 108.0, 108.0, 107.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 126.0, 187.0, 132.0, 128.0, 157.0, 128.0, 166.0, 131.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 167.0, 161.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 121.0, 76.0, 76.0, 74.0, 74.0, 102.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 129.0, 87.0, 86.0, 85.0, 115.0, 85.0, 85.0, 130.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 59.0, 57.0, 55.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 82.0, 82.0, 77.0, 80.0, 78.0, 80.0, 93.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 120.0, 128.0, 121.0, 122.0, 116.0, 133.0, 127.0, 121.0], "value": 123.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 168.0, 164.0, 168.0, 160.0, 157.0, 157.0, 161.0, 158.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 63.0, 61.0, 66.0, 62.0, 61.0, 62.0, 61.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1495.1, "alertThreshold": 2.0}]} 02:49:15 INFO - Return code: 0 02:49:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:49:15 INFO - # TBPL SUCCESS # 02:49:15 INFO - Running post-action listener: _resource_record_post_action 02:49:15 INFO - ##### 02:49:15 INFO - ##### Finished run-tests step (success) 02:49:15 INFO - ##### 02:49:15 INFO - Running post-run listener: _resource_record_post_run 02:49:16 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 568541184; Read time: 0; Write time: 643184 02:49:16 INFO - TinderboxPrint: CPU usage
13.1% 02:49:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:49:16 INFO - TinderboxPrint: I/O write bytes / time
568,541,184 / 643,184 02:49:16 INFO - TinderboxPrint: CPU idle
8,277.0 (86.8%) 02:49:16 INFO - TinderboxPrint: CPU user
1,207.6 (12.7%) 02:49:16 INFO - TinderboxPrint: Swap in / out
0 / 0 02:49:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256811008; Read time: 0; Write time: 366828 02:49:16 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 295403520; Read time: 0; Write time: 268720 02:49:16 INFO - Running post-run listener: _upload_blobber_files 02:49:16 INFO - Blob upload gear active. 02:49:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:49:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:49:17 INFO - (blobuploader) - INFO - Open directory for files ... 02:49:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:49:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:21 INFO - (blobuploader) - INFO - Done attempting. 02:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:21 INFO - (blobuploader) - INFO - Done attempting. 02:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:49:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:22 INFO - (blobuploader) - INFO - Done attempting. 02:49:22 INFO - (blobuploader) - INFO - Iteration through files over. 02:49:22 INFO - Return code: 0 02:49:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:49:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:49:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92fe2a05fd26aa37ee3bf79b40b4096ef17150b7f8ea294bbca1dce9e9ebbe64d0b1b8f42cdd9e078825cbdc649b3704091d1ee841a5ba96ee6f8e633805b2d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/049479e2d71131e252a44d93105d0fc5d4ef159fc85d23b30805d216be919eb8e78f10925c34d8d0a15b6378b9673e0eeed59c206a2529ca8f93333695c7f72c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a93394c98e0290b702f9f36450053647cb855d25c0f46924555ea786b4b69666587b5fdd0c91df0327ec17d87923caec4d57b1b68f73691e6dcc84ce5444a032"} 02:49:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:49:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:49:22 INFO - Contents: 02:49:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92fe2a05fd26aa37ee3bf79b40b4096ef17150b7f8ea294bbca1dce9e9ebbe64d0b1b8f42cdd9e078825cbdc649b3704091d1ee841a5ba96ee6f8e633805b2d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/049479e2d71131e252a44d93105d0fc5d4ef159fc85d23b30805d216be919eb8e78f10925c34d8d0a15b6378b9673e0eeed59c206a2529ca8f93333695c7f72c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a93394c98e0290b702f9f36450053647cb855d25c0f46924555ea786b4b69666587b5fdd0c91df0327ec17d87923caec4d57b1b68f73691e6dcc84ce5444a032"} 02:49:22 INFO - Running post-run listener: copy_logs_to_upload_dir 02:49:22 INFO - Copying logs to upload dir... 02:49:22 INFO - mkdir: /builds/slave/test/build/upload/logs 02:49:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.833140 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 02:49:22.150255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:49:22.153927) ========= 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=fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92fe2a05fd26aa37ee3bf79b40b4096ef17150b7f8ea294bbca1dce9e9ebbe64d0b1b8f42cdd9e078825cbdc649b3704091d1ee841a5ba96ee6f8e633805b2d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/049479e2d71131e252a44d93105d0fc5d4ef159fc85d23b30805d216be919eb8e78f10925c34d8d0a15b6378b9673e0eeed59c206a2529ca8f93333695c7f72c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a93394c98e0290b702f9f36450053647cb855d25c0f46924555ea786b4b69666587b5fdd0c91df0327ec17d87923caec4d57b1b68f73691e6dcc84ce5444a032"} build_url:https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/coef1JoHRl-1MDVFBqozgA/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/Mozilla-Inbound/sha512/92fe2a05fd26aa37ee3bf79b40b4096ef17150b7f8ea294bbca1dce9e9ebbe64d0b1b8f42cdd9e078825cbdc649b3704091d1ee841a5ba96ee6f8e633805b2d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/049479e2d71131e252a44d93105d0fc5d4ef159fc85d23b30805d216be919eb8e78f10925c34d8d0a15b6378b9673e0eeed59c206a2529ca8f93333695c7f72c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a93394c98e0290b702f9f36450053647cb855d25c0f46924555ea786b4b69666587b5fdd0c91df0327ec17d87923caec4d57b1b68f73691e6dcc84ce5444a032"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:49:22.178785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:49:22.179104) ========= 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=fa44defc139c4ba8574fe040000001db-1467106126.77827-1358063100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:49:22.261447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:49:22.261765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:49:22.262041) ========= ========= Total master_lag: 0.16 =========