builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1467106182.98 results: success (0) buildid: 20160627223058 builduid: 7ce57ad2a4e64d6cb7e4e5234b1bf8bf revision: e30eb329b1320c54228eb5fd5a6f4246f0558241 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:42.981204) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:42.981967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:42.982580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:42.998689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 02:29:42.999151) ========= 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=1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 02:29:43-- 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% 62.1M=0s 2016-06-28 02:29:44 (62.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.986585 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 02:29:44.003021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.003669) ========= 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=1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014387 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.057681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.058443) ========= 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=1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 02:29:44,666 truncating revision to first 12 chars 2016-06-28 02:29:44,666 Setting DEBUG logging. 2016-06-28 02:29:44,666 attempt 1/10 2016-06-28 02:29:44,666 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:29:45,036 unpacking tar archive at: mozilla-inbound-e30eb329b132/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.774907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.775286) ========= script_repo_revision: e30eb329b1320c54228eb5fd5a6f4246f0558241 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.775814) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.776144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:29:44.786912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-28 02:29:44.787295) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:29:45 INFO - MultiFileLogger online at 20160628 02:29:45 in /builds/slave/test 02:29:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:29:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:29:45 INFO - {'append_to_log': False, 02:29:45 INFO - 'base_work_dir': '/builds/slave/test', 02:29:45 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:29:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:29:45 INFO - 'branch': 'Mozilla-Inbound', 02:29:45 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:45 INFO - 'config_files': ('talos/linux_config.py',), 02:29:45 INFO - 'default_actions': ('clobber', 02:29:45 INFO - 'read-buildbot-config', 02:29:45 INFO - 'download-and-extract', 02:29:45 INFO - 'populate-webroot', 02:29:45 INFO - 'create-virtualenv', 02:29:45 INFO - 'install', 02:29:45 INFO - 'run-tests'), 02:29:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:45 INFO - 'download_minidump_stackwalk': True, 02:29:45 INFO - 'download_symbols': 'ondemand', 02:29:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:45 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:45 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:45 INFO - 'installer_path': 'installer.exe', 02:29:45 INFO - 'log_level': 'info', 02:29:45 INFO - 'log_name': 'talos', 02:29:45 INFO - 'log_to_console': True, 02:29:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:29:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:29:45 INFO - 'opt_config_files': (), 02:29:45 INFO - 'pip_index': False, 02:29:45 INFO - 'sps_profile': False, 02:29:45 INFO - 'sps_profile_interval': 0, 02:29:45 INFO - 'suite': 'dromaeojs-e10s', 02:29:45 INFO - 'system_bits': '32', 02:29:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:45 INFO - 'title': 'talos-linux64-ix-027', 02:29:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:45 INFO - 'use_talos_json': True, 02:29:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:29:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:45 INFO - 'work_dir': 'build'} 02:29:45 INFO - ##### 02:29:45 INFO - ##### Running clobber step. 02:29:45 INFO - ##### 02:29:45 INFO - Running pre-action listener: _resource_record_pre_action 02:29:45 INFO - Running main action method: clobber 02:29:45 INFO - rmtree: /builds/slave/test/build 02:29:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:29:46 INFO - Running post-action listener: _resource_record_post_action 02:29:46 INFO - ##### 02:29:46 INFO - ##### Finished clobber step (success) 02:29:46 INFO - ##### 02:29:46 INFO - ##### 02:29:46 INFO - ##### Running read-buildbot-config step. 02:29:46 INFO - ##### 02:29:46 INFO - Running pre-action listener: _resource_record_pre_action 02:29:46 INFO - Running main action method: read_buildbot_config 02:29:46 INFO - Using buildbot properties: 02:29:46 INFO - { 02:29:46 INFO - "project": "", 02:29:46 INFO - "product": "firefox", 02:29:46 INFO - "script_repo_revision": "production", 02:29:46 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 02:29:46 INFO - "repository": "", 02:29:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 02:29:46 INFO - "buildid": "20160627223058", 02:29:46 INFO - "pgo_build": "True", 02:29:46 INFO - "basedir": "/builds/slave/test", 02:29:46 INFO - "buildnumber": 1227, 02:29:46 INFO - "slavename": "talos-linux64-ix-027", 02:29:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:29:46 INFO - "platform": "ubuntu64_hw", 02:29:46 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:29:46 INFO - "branch": "mozilla-inbound", 02:29:46 INFO - "repo_path": "integration/mozilla-inbound", 02:29:46 INFO - "revision": "e30eb329b1320c54228eb5fd5a6f4246f0558241", 02:29:46 INFO - "stage_platform": "linux64-pgo", 02:29:46 INFO - "builduid": "7ce57ad2a4e64d6cb7e4e5234b1bf8bf", 02:29:46 INFO - "slavebuilddir": "test" 02:29:46 INFO - } 02:29:46 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:29:46 INFO - Running post-action listener: _resource_record_post_action 02:29:46 INFO - ##### 02:29:46 INFO - ##### Finished read-buildbot-config step (success) 02:29:46 INFO - ##### 02:29:46 INFO - ##### 02:29:46 INFO - ##### Running download-and-extract step. 02:29:46 INFO - ##### 02:29:46 INFO - Running pre-action listener: _resource_record_pre_action 02:29:46 INFO - Running main action method: download_and_extract 02:29:46 INFO - mkdir: /builds/slave/test/build/tests 02:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:46 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:29:46 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:29:46 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:29:46 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:29:46 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:29:47 INFO - Downloaded 1361 bytes. 02:29:47 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:29:47 INFO - Using the following test package requirements: 02:29:47 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:29:47 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:29:47 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:29:47 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'jsshell-linux-x86_64.zip'], 02:29:47 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:29:47 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:29:47 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:29:47 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:29:47 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:29:47 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:47 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:29:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:29:47 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:47 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:29:47 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:29:47 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:29:47 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:29:47 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:29:48 INFO - Downloaded 24282915 bytes. 02:29:48 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:29:48 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:29:49 INFO - Return code: 0 02:29:49 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:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:49 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:29:49 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:29:49 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:29:49 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:29:49 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:29:50 INFO - Downloaded 24282915 bytes. 02:29:50 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:29:50 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:29:52 INFO - Return code: 0 02:29:52 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:52 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:29:52 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:29:52 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:29:52 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:29:52 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:29:53 INFO - Downloaded 14405240 bytes. 02:29:53 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:29:53 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:29:53 INFO - Return code: 0 02:29: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:29:53 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:29: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.tar.bz2 02:29: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.tar.bz2 02:29: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.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:29:53 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:29:58 INFO - Downloaded 60295753 bytes. 02:29:58 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:29:58 INFO - mkdir: /builds/slave/test/properties 02:29:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:29:58 INFO - Writing to file /builds/slave/test/properties/build_url 02:29:58 INFO - Contents: 02:29:58 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:29:59 INFO - Running post-action listener: _resource_record_post_action 02:29:59 INFO - Running post-action listener: set_extra_try_arguments 02:29:59 INFO - ##### 02:29:59 INFO - ##### Finished download-and-extract step (success) 02:29:59 INFO - ##### 02:29:59 INFO - ##### 02:29:59 INFO - ##### Running populate-webroot step. 02:29:59 INFO - ##### 02:29:59 INFO - Running pre-action listener: _resource_record_pre_action 02:29:59 INFO - Running main action method: populate_webroot 02:29:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:29:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:29:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:29:59 INFO - '--tppagecycles', 02:29:59 INFO - '7'], 02:29:59 INFO - 'tests': ['tsvgm']}}, 02:29:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:29:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:29:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:29:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:29:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['damp', 'tps']}, 02:29:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'tests': ['damp', 'tps']}, 02:29:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['dromaeo_dom']}, 02:29:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:29:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['basic_compositor_video']}, 02:29:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:29:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['a11yr', 02:29:59 INFO - 'ts_paint', 02:29:59 INFO - 'tpaint', 02:29:59 INFO - 'sessionrestore', 02:29:59 INFO - 'sessionrestore_no_auto_restore', 02:29:59 INFO - 'tabpaint']}, 02:29:59 INFO - 'other-e10s': {'tests': ['a11yr', 02:29:59 INFO - 'ts_paint', 02:29:59 INFO - 'tpaint', 02:29:59 INFO - 'sessionrestore', 02:29:59 INFO - 'sessionrestore_no_auto_restore', 02:29:59 INFO - 'tabpaint']}, 02:29:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:29:59 INFO - 'ts_paint', 02:29:59 INFO - 'tpaint', 02:29:59 INFO - 'sessionrestore', 02:29:59 INFO - 'sessionrestore_no_auto_restore', 02:29:59 INFO - 'tabpaint']}, 02:29:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:29:59 INFO - 'ts_paint', 02:29:59 INFO - 'tpaint', 02:29:59 INFO - 'sessionrestore', 02:29:59 INFO - 'sessionrestore_no_auto_restore', 02:29:59 INFO - 'tabpaint']}, 02:29:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['a11yr', 02:29:59 INFO - 'ts_paint', 02:29:59 INFO - 'tpaint', 02:29:59 INFO - 'sessionrestore', 02:29:59 INFO - 'sessionrestore_no_auto_restore', 02:29:59 INFO - 'tabpaint']}, 02:29:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['a11yr', 02:29:59 INFO - 'ts_paint', 02:29:59 INFO - 'tpaint', 02:29:59 INFO - 'sessionrestore', 02:29:59 INFO - 'sessionrestore_no_auto_restore', 02:29:59 INFO - 'tabpaint']}, 02:29:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['tsvgx', 02:29:59 INFO - 'tsvgr_opacity', 02:29:59 INFO - 'tart', 02:29:59 INFO - 'tscrollx', 02:29:59 INFO - 'cart']}, 02:29:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:29:59 INFO - 'tsvgr_opacity', 02:29:59 INFO - 'tart', 02:29:59 INFO - 'tscrollx', 02:29:59 INFO - 'cart']}, 02:29:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'talos_options': ['--disable-e10s'], 02:29:59 INFO - 'tests': ['tp5o']}, 02:29:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'tests': ['tp5o']}, 02:29:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'talos_options': ['--disable-e10s', 02:29:59 INFO - '--xperf_path', 02:29:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:59 INFO - 'tests': ['tp5n']}, 02:29:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:59 INFO - 'talos_options': ['--xperf_path', 02:29:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:59 INFO - 'tests': ['tp5n']}}, 02:29:59 INFO - 'talos.zip': {'path': '', 02:29:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:29:59 INFO - Running post-action listener: _resource_record_post_action 02:29:59 INFO - ##### 02:29:59 INFO - ##### Finished populate-webroot step (success) 02:29:59 INFO - ##### 02:29:59 INFO - ##### 02:29:59 INFO - ##### Running create-virtualenv step. 02:29:59 INFO - ##### 02:29:59 INFO - Running pre-action listener: _resource_record_pre_action 02:29:59 INFO - Running main action method: create_virtualenv 02:29:59 INFO - Creating virtualenv /builds/slave/test/build/venv 02:29:59 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:29:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:29:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:29:59 INFO - Using real prefix '/usr' 02:29:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:30:00 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:01 INFO - Installing pip.................done. 02:30:01 INFO - Return code: 0 02:30:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:01 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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:01 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:30:01 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:30:02 INFO - Using env: {'DISPLAY': ':0', 02:30:02 INFO - 'HOME': '/home/cltbld', 02:30:02 INFO - 'LANG': 'en_US.UTF-8', 02:30:02 INFO - 'LANGUAGE': 'en_US:en', 02:30:02 INFO - 'LOGNAME': 'cltbld', 02:30:02 INFO - 'MAIL': '/var/mail/cltbld', 02:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:02 INFO - 'MOZ_NO_REMOTE': '1', 02:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:02 INFO - 'NO_EM_RESTART': '1', 02:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:02 INFO - 'PWD': '/builds/slave/test', 02:30:02 INFO - 'SHELL': '/bin/bash', 02:30:02 INFO - 'SHLVL': '1', 02:30:02 INFO - 'TERM': 'linux', 02:30:02 INFO - 'TMOUT': '86400', 02:30:02 INFO - 'USER': 'cltbld', 02:30:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:02 INFO - '_': '/tools/buildbot/bin/python'} 02:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:02 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:30:02 INFO - Cleaning up... 02:30:02 INFO - Return code: 0 02:30:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:30: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:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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', '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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:30: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 psutil>=3.1.1 02:30:02 INFO - Using env: {'DISPLAY': ':0', 02:30:02 INFO - 'HOME': '/home/cltbld', 02:30:02 INFO - 'LANG': 'en_US.UTF-8', 02:30:02 INFO - 'LANGUAGE': 'en_US:en', 02:30:02 INFO - 'LOGNAME': 'cltbld', 02:30:02 INFO - 'MAIL': '/var/mail/cltbld', 02:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:02 INFO - 'MOZ_NO_REMOTE': '1', 02:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:02 INFO - 'NO_EM_RESTART': '1', 02:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:02 INFO - 'PWD': '/builds/slave/test', 02:30:02 INFO - 'SHELL': '/bin/bash', 02:30:02 INFO - 'SHLVL': '1', 02:30:02 INFO - 'TERM': 'linux', 02:30:02 INFO - 'TMOUT': '86400', 02:30:02 INFO - 'USER': 'cltbld', 02:30:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:02 INFO - '_': '/tools/buildbot/bin/python'} 02:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:02 INFO - Downloading/unpacking psutil>=3.1.1 02:30: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:30: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:30: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:30: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:30: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:30: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:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:04 INFO - Installing collected packages: psutil 02:30:04 INFO - Running setup.py install for psutil 02:30:04 INFO - building 'psutil._psutil_linux' extension 02:30:04 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:30:04 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:30:04 INFO - building 'psutil._psutil_posix' extension 02:30:04 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:30:04 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:30:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:04 INFO - Successfully installed psutil 02:30:04 INFO - Cleaning up... 02:30:04 INFO - Return code: 0 02:30:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:04 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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:04 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:30:04 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:30:04 INFO - Using env: {'DISPLAY': ':0', 02:30:04 INFO - 'HOME': '/home/cltbld', 02:30:04 INFO - 'LANG': 'en_US.UTF-8', 02:30:04 INFO - 'LANGUAGE': 'en_US:en', 02:30:04 INFO - 'LOGNAME': 'cltbld', 02:30:04 INFO - 'MAIL': '/var/mail/cltbld', 02:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:04 INFO - 'MOZ_NO_REMOTE': '1', 02:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:04 INFO - 'NO_EM_RESTART': '1', 02:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:04 INFO - 'PWD': '/builds/slave/test', 02:30:04 INFO - 'SHELL': '/bin/bash', 02:30:04 INFO - 'SHLVL': '1', 02:30:04 INFO - 'TERM': 'linux', 02:30:04 INFO - 'TMOUT': '86400', 02:30:04 INFO - 'USER': 'cltbld', 02:30:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:04 INFO - '_': '/tools/buildbot/bin/python'} 02:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:30: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:30: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:30: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:30: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:30: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:30: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:30:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:30:07 INFO - Installing collected packages: mozsystemmonitor 02:30:07 INFO - Running setup.py install for mozsystemmonitor 02:30:07 INFO - Successfully installed mozsystemmonitor 02:30:07 INFO - Cleaning up... 02:30:07 INFO - Return code: 0 02:30:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:30: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:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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', '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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:30: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 jsonschema==2.5.1 02:30:07 INFO - Using env: {'DISPLAY': ':0', 02:30:07 INFO - 'HOME': '/home/cltbld', 02:30:07 INFO - 'LANG': 'en_US.UTF-8', 02:30:07 INFO - 'LANGUAGE': 'en_US:en', 02:30:07 INFO - 'LOGNAME': 'cltbld', 02:30:07 INFO - 'MAIL': '/var/mail/cltbld', 02:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:07 INFO - 'MOZ_NO_REMOTE': '1', 02:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:07 INFO - 'NO_EM_RESTART': '1', 02:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:07 INFO - 'PWD': '/builds/slave/test', 02:30:07 INFO - 'SHELL': '/bin/bash', 02:30:07 INFO - 'SHLVL': '1', 02:30:07 INFO - 'TERM': 'linux', 02:30:07 INFO - 'TMOUT': '86400', 02:30:07 INFO - 'USER': 'cltbld', 02:30:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:07 INFO - '_': '/tools/buildbot/bin/python'} 02:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:07 INFO - Downloading/unpacking jsonschema==2.5.1 02:30: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:30: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:30: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:30: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:30: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:30: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:30:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:30: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:30: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:30: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:30: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:30: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:30: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:30:09 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:09 INFO - warning: no files found matching '*.txt' 02:30:09 INFO - no previously-included directories found matching 'build' 02:30:09 INFO - no previously-included directories found matching 'dist' 02:30:09 INFO - no previously-included directories found matching '.git*' 02:30:09 INFO - Installing collected packages: jsonschema, functools32 02:30:09 INFO - Running setup.py install for functools32 02:30:09 INFO - warning: no files found matching '*.txt' 02:30:09 INFO - no previously-included directories found matching 'build' 02:30:09 INFO - no previously-included directories found matching 'dist' 02:30:09 INFO - no previously-included directories found matching '.git*' 02:30:09 INFO - Successfully installed jsonschema functools32 02:30:09 INFO - Cleaning up... 02:30:09 INFO - Return code: 0 02:30:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:30:09 INFO - Using env: {'DISPLAY': ':0', 02:30:09 INFO - 'HOME': '/home/cltbld', 02:30:09 INFO - 'LANG': 'en_US.UTF-8', 02:30:09 INFO - 'LANGUAGE': 'en_US:en', 02:30:09 INFO - 'LOGNAME': 'cltbld', 02:30:09 INFO - 'MAIL': '/var/mail/cltbld', 02:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:09 INFO - 'MOZ_NO_REMOTE': '1', 02:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:09 INFO - 'NO_EM_RESTART': '1', 02:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:09 INFO - 'PWD': '/builds/slave/test', 02:30:09 INFO - 'SHELL': '/bin/bash', 02:30:09 INFO - 'SHLVL': '1', 02:30:09 INFO - 'TERM': 'linux', 02:30:09 INFO - 'TMOUT': '86400', 02:30:09 INFO - 'USER': 'cltbld', 02:30:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:09 INFO - '_': '/tools/buildbot/bin/python'} 02:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:30: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:30: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:30: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:30: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:30: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:30: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:30:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:30:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:30:12 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:30:12 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:30:12 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:30:12 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:30:12 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:30:12 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:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:30:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:30:12 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:30:12 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:30:12 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:30:12 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:30:12 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:30:12 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:30:12 INFO - Downloading docopt-0.6.1.tar.gz 02:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:30:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:30:12 INFO - Running setup.py install for blobuploader 02:30:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:30:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:30:12 INFO - Running setup.py install for requests 02:30:13 INFO - Running setup.py install for docopt 02:30:13 INFO - Successfully installed blobuploader requests docopt 02:30:13 INFO - Cleaning up... 02:30:13 INFO - Return code: 0 02:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:13 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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:13 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:30:13 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:30:13 INFO - Using env: {'DISPLAY': ':0', 02:30:13 INFO - 'HOME': '/home/cltbld', 02:30:13 INFO - 'LANG': 'en_US.UTF-8', 02:30:13 INFO - 'LANGUAGE': 'en_US:en', 02:30:13 INFO - 'LOGNAME': 'cltbld', 02:30:13 INFO - 'MAIL': '/var/mail/cltbld', 02:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:13 INFO - 'MOZ_NO_REMOTE': '1', 02:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:13 INFO - 'NO_EM_RESTART': '1', 02:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:13 INFO - 'PWD': '/builds/slave/test', 02:30:13 INFO - 'SHELL': '/bin/bash', 02:30:13 INFO - 'SHLVL': '1', 02:30:13 INFO - 'TERM': 'linux', 02:30:13 INFO - 'TMOUT': '86400', 02:30:13 INFO - 'USER': 'cltbld', 02:30:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:13 INFO - '_': '/tools/buildbot/bin/python'} 02:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:13 INFO - Running setup.py (path:/tmp/pip-TVfpY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:13 INFO - Running setup.py (path:/tmp/pip-JpPaNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:13 INFO - Running setup.py (path:/tmp/pip-6AM6r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:13 INFO - Running setup.py (path:/tmp/pip-LsekSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:13 INFO - Running setup.py (path:/tmp/pip-Vv2Suq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:13 INFO - Running setup.py (path:/tmp/pip-uyB0QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:13 INFO - Running setup.py (path:/tmp/pip-zAMZNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:14 INFO - Running setup.py (path:/tmp/pip-q_hPXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:14 INFO - Running setup.py (path:/tmp/pip-oamtvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:14 INFO - Running setup.py (path:/tmp/pip-GIYo1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:14 INFO - Running setup.py (path:/tmp/pip-iDe0Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:14 INFO - Running setup.py (path:/tmp/pip-KDWfaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:14 INFO - Running setup.py (path:/tmp/pip-jPqhZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:14 INFO - Running setup.py (path:/tmp/pip-kGbGW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:14 INFO - Running setup.py (path:/tmp/pip-AMZWBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:14 INFO - Running setup.py (path:/tmp/pip-5yzZuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:14 INFO - Running setup.py (path:/tmp/pip-lQFPc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:30:14 INFO - Running setup.py install for manifestparser 02:30:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:30:14 INFO - Running setup.py install for mozcrash 02:30:14 INFO - Running setup.py install for mozdebug 02:30:15 INFO - Running setup.py install for mozdevice 02:30:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Running setup.py install for mozfile 02:30:15 INFO - Running setup.py install for mozhttpd 02:30:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Running setup.py install for mozinfo 02:30:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Running setup.py install for mozInstall 02:30:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Running setup.py install for mozleak 02:30:15 INFO - Running setup.py install for mozlog 02:30:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Running setup.py install for moznetwork 02:30:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:30:15 INFO - Running setup.py install for mozprocess 02:30:15 INFO - Running setup.py install for mozprofile 02:30:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:30:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:30:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:30:16 INFO - Running setup.py install for mozrunner 02:30:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:30:16 INFO - Running setup.py install for mozscreenshot 02:30:16 INFO - Running setup.py install for moztest 02:30:16 INFO - Running setup.py install for mozversion 02:30:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:30:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:30:16 INFO - Cleaning up... 02:30:16 INFO - Return code: 0 02:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:16 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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:16 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:30:16 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:30:16 INFO - Using env: {'DISPLAY': ':0', 02:30:16 INFO - 'HOME': '/home/cltbld', 02:30:16 INFO - 'LANG': 'en_US.UTF-8', 02:30:16 INFO - 'LANGUAGE': 'en_US:en', 02:30:16 INFO - 'LOGNAME': 'cltbld', 02:30:16 INFO - 'MAIL': '/var/mail/cltbld', 02:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:16 INFO - 'MOZ_NO_REMOTE': '1', 02:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:16 INFO - 'NO_EM_RESTART': '1', 02:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:16 INFO - 'PWD': '/builds/slave/test', 02:30:16 INFO - 'SHELL': '/bin/bash', 02:30:16 INFO - 'SHLVL': '1', 02:30:16 INFO - 'TERM': 'linux', 02:30:16 INFO - 'TMOUT': '86400', 02:30:16 INFO - 'USER': 'cltbld', 02:30:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:16 INFO - '_': '/tools/buildbot/bin/python'} 02:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:16 INFO - Running setup.py (path:/tmp/pip-YERtMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:16 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:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:16 INFO - Running setup.py (path:/tmp/pip-Xsb4La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:16 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:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:16 INFO - Running setup.py (path:/tmp/pip-ush5uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:16 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:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:16 INFO - Running setup.py (path:/tmp/pip-TxzNSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:17 INFO - Running setup.py (path:/tmp/pip-VtwP5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:17 INFO - Running setup.py (path:/tmp/pip-aiYv2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:17 INFO - Running setup.py (path:/tmp/pip-TC18zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:17 INFO - Running setup.py (path:/tmp/pip-oGuyTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:17 INFO - Running setup.py (path:/tmp/pip-Iti8R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:17 INFO - Running setup.py (path:/tmp/pip-FTWUQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:17 INFO - Running setup.py (path:/tmp/pip-ES6mv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:17 INFO - Running setup.py (path:/tmp/pip-9gigHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:17 INFO - Running setup.py (path:/tmp/pip-kH9J8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:17 INFO - Running setup.py (path:/tmp/pip-miMgl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:17 INFO - Running setup.py (path:/tmp/pip-ZbpG43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:17 INFO - Running setup.py (path:/tmp/pip-IQb1oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:17 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:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:17 INFO - Running setup.py (path:/tmp/pip-J8TvgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:18 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:30:18 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:30:18 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:30:18 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:30:18 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:30:18 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:30:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:30: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:30: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:30: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:30: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:30: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:30: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:30:19 INFO - Downloading blessings-1.6.tar.gz 02:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:30:19 INFO - Installing collected packages: blessings 02:30:19 INFO - Running setup.py install for blessings 02:30:20 INFO - Successfully installed blessings 02:30:20 INFO - Cleaning up... 02:30:20 INFO - Return code: 0 02:30:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:30:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:20 INFO - Reading from file tmpfile_stdout 02:30:20 INFO - Current package versions: 02:30:20 INFO - argparse == 1.2.1 02:30:20 INFO - blessings == 1.6 02:30:20 INFO - blobuploader == 1.2.4 02:30:20 INFO - docopt == 0.6.1 02:30:20 INFO - functools32 == 3.2.3-2 02:30:20 INFO - jsonschema == 2.5.1 02:30:20 INFO - manifestparser == 1.1 02:30:20 INFO - mozInstall == 1.12 02:30:20 INFO - mozcrash == 0.17 02:30:20 INFO - mozdebug == 0.1 02:30:20 INFO - mozdevice == 0.48 02:30:20 INFO - mozfile == 1.2 02:30:20 INFO - mozhttpd == 0.7 02:30:20 INFO - mozinfo == 0.9 02:30:20 INFO - mozleak == 0.1 02:30:20 INFO - mozlog == 3.2 02:30:20 INFO - moznetwork == 0.27 02:30:20 INFO - mozprocess == 0.22 02:30:20 INFO - mozprofile == 0.28 02:30:20 INFO - mozrunner == 6.11 02:30:20 INFO - mozscreenshot == 0.1 02:30:20 INFO - mozsystemmonitor == 0.3 02:30:20 INFO - moztest == 0.7 02:30:20 INFO - mozversion == 1.4 02:30:20 INFO - psutil == 3.1.1 02:30:20 INFO - requests == 1.2.3 02:30:20 INFO - wsgiref == 0.1.2 02:30:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:20 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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:20 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:30:20 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:30:20 INFO - Using env: {'DISPLAY': ':0', 02:30:20 INFO - 'HOME': '/home/cltbld', 02:30:20 INFO - 'LANG': 'en_US.UTF-8', 02:30:20 INFO - 'LANGUAGE': 'en_US:en', 02:30:20 INFO - 'LOGNAME': 'cltbld', 02:30:20 INFO - 'MAIL': '/var/mail/cltbld', 02:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:20 INFO - 'MOZ_NO_REMOTE': '1', 02:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:20 INFO - 'NO_EM_RESTART': '1', 02:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:20 INFO - 'PWD': '/builds/slave/test', 02:30:20 INFO - 'SHELL': '/bin/bash', 02:30:20 INFO - 'SHLVL': '1', 02:30:20 INFO - 'TERM': 'linux', 02:30:20 INFO - 'TMOUT': '86400', 02:30:20 INFO - 'USER': 'cltbld', 02:30:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:20 INFO - '_': '/tools/buildbot/bin/python'} 02:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:20 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:30:20 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:30:20 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:30:20 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:30:20 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:30:20 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:30:20 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:30:20 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:30:20 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:30:20 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:30:20 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:30:20 INFO - Cleaning up... 02:30:20 INFO - Return code: 0 02:30:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:20 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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:20 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:30:20 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:30:20 INFO - Using env: {'DISPLAY': ':0', 02:30:20 INFO - 'HOME': '/home/cltbld', 02:30:20 INFO - 'LANG': 'en_US.UTF-8', 02:30:20 INFO - 'LANGUAGE': 'en_US:en', 02:30:20 INFO - 'LOGNAME': 'cltbld', 02:30:20 INFO - 'MAIL': '/var/mail/cltbld', 02:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:20 INFO - 'MOZ_NO_REMOTE': '1', 02:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:20 INFO - 'NO_EM_RESTART': '1', 02:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:20 INFO - 'PWD': '/builds/slave/test', 02:30:20 INFO - 'SHELL': '/bin/bash', 02:30:20 INFO - 'SHLVL': '1', 02:30:20 INFO - 'TERM': 'linux', 02:30:20 INFO - 'TMOUT': '86400', 02:30:20 INFO - 'USER': 'cltbld', 02:30:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:20 INFO - '_': '/tools/buildbot/bin/python'} 02:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:30:20 INFO - Cleaning up... 02:30:20 INFO - Return code: 0 02:30:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:20 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 0x7f06fd744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd79480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, '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': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', '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:30:20 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:30:20 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:30:20 INFO - Using env: {'DISPLAY': ':0', 02:30:20 INFO - 'HOME': '/home/cltbld', 02:30:20 INFO - 'LANG': 'en_US.UTF-8', 02:30:20 INFO - 'LANGUAGE': 'en_US:en', 02:30:20 INFO - 'LOGNAME': 'cltbld', 02:30:20 INFO - 'MAIL': '/var/mail/cltbld', 02:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:20 INFO - 'MOZ_NO_REMOTE': '1', 02:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:20 INFO - 'NO_EM_RESTART': '1', 02:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:20 INFO - 'PWD': '/builds/slave/test', 02:30:20 INFO - 'SHELL': '/bin/bash', 02:30:20 INFO - 'SHLVL': '1', 02:30:20 INFO - 'TERM': 'linux', 02:30:20 INFO - 'TMOUT': '86400', 02:30:20 INFO - 'USER': 'cltbld', 02:30:20 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:20 INFO - '_': '/tools/buildbot/bin/python'} 02:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:21 INFO - Downloading/unpacking flake8 02:30: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:30: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:30: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:30: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:30: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:30: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:30:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:30:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:30:22 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:30:22 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:30:22 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:30:22 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:30:22 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:30:22 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:30:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:30:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:23 INFO - no previously-included directories found matching 'docs/_build' 02:30:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:30:23 INFO - Running setup.py install for pep8 02:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:23 INFO - no previously-included directories found matching 'docs/_build' 02:30:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:30:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:30:23 INFO - Cleaning up... 02:30:23 INFO - Return code: 0 02:30:23 INFO - Running post-action listener: _resource_record_post_action 02:30:23 INFO - Running post-action listener: _start_resource_monitoring 02:30:23 INFO - Starting resource monitoring. 02:30:23 INFO - ##### 02:30:23 INFO - ##### Finished create-virtualenv step (success) 02:30:23 INFO - ##### 02:30:23 INFO - ##### 02:30:23 INFO - ##### Running install step. 02:30:23 INFO - ##### 02:30:23 INFO - Running pre-action listener: _resource_record_pre_action 02:30:23 INFO - Running main action method: install 02:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:24 INFO - Reading from file tmpfile_stdout 02:30:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:30:24 INFO - Reading from file tmpfile_stdout 02:30:24 INFO - Output received: 02:30:24 INFO - Usage: mozinstall [options] installer 02:30:24 INFO - Options: 02:30:24 INFO - -h, --help show this help message and exit 02:30:24 INFO - -d DEST, --destination=DEST 02:30:24 INFO - Directory to install application into. [default: 02:30:24 INFO - "/builds/slave/test"] 02:30:24 INFO - --app=APP Application being installed. [default: firefox] 02:30:24 INFO - mkdir: /builds/slave/test/build/application 02:30:24 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:30:24 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:30:41 INFO - Reading from file tmpfile_stdout 02:30:41 INFO - Output received: 02:30:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:30:41 INFO - Running post-action listener: _resource_record_post_action 02:30:41 INFO - ##### 02:30:41 INFO - ##### Finished install step (success) 02:30:41 INFO - ##### 02:30:41 INFO - ##### 02:30:41 INFO - ##### Running run-tests step. 02:30:41 INFO - ##### 02:30:41 INFO - Running pre-action listener: _resource_record_pre_action 02:30:41 INFO - Running main action method: run_tests 02:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:41 INFO - Python 2.7.3 02:30:41 INFO - Return code: 0 02:30:41 INFO - grabbing minidump binary from tooltool 02:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:41 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 0xe086f0>, '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 0xe095f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe09aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:41 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:30:41 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:30:41 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:30:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:41 INFO - Return code: 0 02:30:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:30:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:30:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:30:42 INFO - Return code: 0 02:30:42 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-e10s', '--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-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:30:42 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-e10s --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-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:30:42 INFO - Using env: {'DISPLAY': ':0', 02:30:42 INFO - 'HOME': '/home/cltbld', 02:30:42 INFO - 'LANG': 'en_US.UTF-8', 02:30:42 INFO - 'LANGUAGE': 'en_US:en', 02:30:42 INFO - 'LOGNAME': 'cltbld', 02:30:42 INFO - 'MAIL': '/var/mail/cltbld', 02:30:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:42 INFO - 'MOZ_NO_REMOTE': '1', 02:30:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:42 INFO - 'NO_EM_RESTART': '1', 02:30:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:42 INFO - 'PWD': '/builds/slave/test', 02:30:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:42 INFO - 'SHELL': '/bin/bash', 02:30:42 INFO - 'SHLVL': '1', 02:30:42 INFO - 'TERM': 'linux', 02:30:42 INFO - 'TMOUT': '86400', 02:30:42 INFO - 'USER': 'cltbld', 02:30:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992', 02:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:42 INFO - '_': '/tools/buildbot/bin/python'} 02:30:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--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-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:30:42 INFO - mozversion application_buildid: 20160627223058 02:30:42 INFO - mozversion application_changeset: e30eb329b1320c54228eb5fd5a6f4246f0558241 02:30:42 INFO - mozversion application_display_name: Nightly 02:30:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:42 INFO - mozversion application_name: Firefox 02:30:42 INFO - mozversion application_remotingname: firefox 02:30:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:30:42 INFO - mozversion application_vendor: Mozilla 02:30:42 INFO - mozversion application_version: 50.0a1 02:30:42 INFO - mozversion platform_buildid: 20160627223058 02:30:42 INFO - mozversion platform_changeset: e30eb329b1320c54228eb5fd5a6f4246f0558241 02:30:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:30:42 INFO - mozversion platform_version: 50.0a1 02:30:42 INFO - using testdate: 1467106242 02:30:42 INFO - actual date: 1467106242 02:30:42 INFO - starting webserver on 'localhost:36019' 02:30:42 INFO - SUITE-START | Running 2 tests 02:30:42 INFO - TEST-START | dromaeo_css 02:30:42 INFO - operating with platform_type : linux_ 02:30:42 INFO - Initialising browser for dromaeo_css test... 02:30:42 INFO - TEST-INFO | started process 13039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7dRz9/profile http://localhost:36019/getInfo.html) 02:30:46 INFO - PROCESS | 13039 | __metrics Screen width/height:1600/1200 02:30:46 INFO - PROCESS | 13039 | colorDepth:24 02:30:46 INFO - PROCESS | 13039 | Browser inner width/height: 1024/697 02:30:46 INFO - PROCESS | 13039 | __metrics 02:30:47 ERROR - PROCESS | 13039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:30:48 INFO - TEST-INFO | 13039: exit 0 02:30:48 INFO - Browser initialized. 02:30:48 INFO - Running cycle 1/1 for dromaeo_css test... 02:30:48 INFO - TEST-INFO | started process 13159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7dRz9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:00 INFO - PROCESS | 13159 | RSS: Main: 167657472 02:31:00 INFO - PROCESS | 13159 | 02:31:49 INFO - PROCESS | 13159 | 1467106309763 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:33:58 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:36019/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36019/tests/dromaeo/cssquery-ext.html) 02:33:58 INFO - PROCESS | 13159 | RSS: Main: 171814912 02:33:58 INFO - PROCESS | 13159 | 02:37:01 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:36019/tests/dromaeo/cssquery-ext.html (next: http://localhost:36019/tests/dromaeo/cssquery-jquery.html) 02:37:01 INFO - PROCESS | 13159 | RSS: Main: 170381312 02:37:01 INFO - PROCESS | 13159 | 02:40:03 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:36019/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36019/tests/dromaeo/cssquery-mootools.html) 02:40:04 INFO - PROCESS | 13159 | RSS: Main: 171507712 02:40:04 INFO - PROCESS | 13159 | 02:43:05 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:36019/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36019/tests/dromaeo/cssquery-prototype.html) 02:43:06 INFO - PROCESS | 13159 | RSS: Main: 169246720 02:43:06 INFO - PROCESS | 13159 | 02:46:09 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:36019/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36019/tests/dromaeo/cssquery-yui.html) 02:46:09 INFO - PROCESS | 13159 | RSS: Main: 171491328 02:46:09 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | Cycle 1(1): loaded http://localhost:36019/tests/dromaeo/cssquery-yui.html (next: http://localhost:36019/tests/dromaeo/cssquery-dojo.html) 02:49:12 INFO - PROCESS | 13159 | RSS: Main: 172314624 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | __start_tp_report 02:49:12 INFO - PROCESS | 13159 | _x_x_mozilla_page_load 02:49:12 INFO - PROCESS | 13159 | _x_x_mozilla_page_load_details 02:49:12 INFO - PROCESS | 13159 | |i|pagename|runs| 02:49:12 INFO - PROCESS | 13159 | |0;dojo.html;3103.596532450782;3172.0642410488904;3177.7934434261765;3192.2338638726696;3202.0553936588703;5441.673499590022;5469.398366179722;5499.587530935176;5505.311836020497;5515.972420137899;5427.511523962842;5476.4249753775875;5503.3120859892515;5547.195656629786;5617.0731829248125;4947;4983.975080124595;5090.490950904898;5154.92267615986;5202.089634313998;702.5484117897797;5071.442141364447;5080.466551012146;5097.23541468779;5128.153854613985;4949.604031677457;4967.205247160437;5006.874828129307;5008.499150084999;5011.523905229015;4939.333190019337;4989.57588604969;4994.9750251248515;5020.221865610836;5025.3718285214345;4864.537868902448;4891.584215341701;4901.1177987962155;4981;5019.824306149304;5451.427600101972;5534.529564986981;5539.473749993744;5550.47270509301;5556.416576259516;5908.4091590841;5929.347771745104;5939.910901336483;5943.286805583314;5945.702714864239;5977.521798256129;6023.066424704178;6023.879522409527;6031.969840150815;6085.117657939618;5545.168224766277;5575.996320662279;5586.469285417838;5592.5246354059545;5602.719864006784;5892.057270836645;5893.3222679391565;5952.404759524013;5963.582549221513;6073.51411887048;5799.449052340021;5804.593678442468;5811.854703632358;5812.88374232513;5822.563307751935;5882.970585147047;5887.646741195542;5888.116782482662;5918.763249470059;5920.940790592125;5719.113537401709;5826.504747096459;5859.472647461749;5897.380775018647;5938.554608404387;5800.709964501758;5887.0580707086665;5900.055991041413;5939.22790037301;5940.257467816523;4523.683342166082;4527.886802829956;4529.524399937959;4531.13908357411;4566.06395688883;3928.7839168845417;3935.5080614923136;3966.3257246268204;3991.4012898064943;4037.4953130858644;5618.943810561842;5642.576806739511;5659.094544872883;5672.432756724377;5692;5865.090910908816;5930.11048342752;5931.851703707355;5943.257092863392;5956.851078723066;5447.836564903059;5526.861828454241;5571.8885622288135;5599.720013999366;5643.746031428595;4991.625628077909;5006.899862002812;5027.472115427828;5054.797808087709;5058.190689489737;6077.265825799587;6095.455447509409;6120.416658367975;6134.957077260912;6141.986572215535;5819.098039803753;5855.03391940325;5880.14737863016;5934.139549765347;5935.525157987437;6164.568480206342;6170.444659980623;6193.628382297076;6194.5044396449075;6208.2239720034995;5729.9713501432225;5817.5345972321265;5821.359650438364;5825.300963884361;5825.970870145622;5880.705964701833;5919.171316015675;5923.703814809156;5979.820605381671;5981.3420523743225;5804.854878628068;5826.475617194473;5826.73779679907;5829.475347218601;5829.912551311649;5630.493255607015;5715.942840571707;5758.2514273144225;5809.041508151107;5809.883802323845;5562.054450743464;5621.9156712650165;5624.6625202487985;5651.88696226065;5745.741441635053;5846.35690074083;5854.736536855767;5855.882882342415;5865.266841644794;5871.383504731942;5541.778328866962;5576.498115169654;5714.628549144292;5717.1995920570325;5732.9394062098645 02:49:12 INFO - PROCESS | 13159 | |1;ext.html;575.9568032397572;627.375761117688;646.7219095788809;651.5829868883915;661.2032500836492;42538.78730606347;43867;43920.3411948821;43989.78005109978;48188.51811481884;43596.78201608996;44485.110297794025;44545.10909781802;44555.33167002498;44674.77662611682;8812.295016398704;8948.149925757076;8952.955235223848;8953.462792232454;8953.507557084391;8786.472811631322;8866.689665861697;8875.822483550324;8886.86669699955;8891.73324800257;8848.292136629087;8870.37907346486;8906.24296934758;8910.777230569256;8974.685885993991;8872.334574906909;8894.688685895962;8921.197092261695;8931.50876701781;8935;8799.516026618534;8906.688265910727;8973.820523589491;8979.730608081769;8984.640614375417;42242.36636450456;42469.362959555634;42533.57466425327;42580;42706;3442.1394651337164;3487.2153765402836;3521.1197200699826;3570.625084366156;3865.3042452358563;32851.50722739161;33027;33349.833250833835;35006.649933500594;35076.82461587676;4417.845375411877;4436.622887054604;4486.282194848841;4502.707324023928;4525.841595544173;333949;334032;334651;335545;336407;59911.700441497516;59933.700331498934;60275.69862150661;60367.39632603706;60687;35867.82066089653;36782;61950;62513;62733.68633156805;16776.83223167777;16904.56311213536;16960.15199240033;16989.40537081196;17009.064501452292;11658.300501969909;11793.528258869721;11814.94092529532;11823.408829558488;11855.110866685032;19625.31311404094;19695.01524923748;19696.803031969783;19737;19796.109175087156;7181.138263408425;7234.625421169961;7309.634518274065;7479.8504029919095;7488.962555187298;1012.5747186181821;1070.7590792071878;1079.3038490173794;1128.8701799293021;1190.2441949362044;32180.83909580437;32807.50788738171;32885.342293154004;32965.83517082399;33088.3382332352;1090.0407641275626;1096.8628921384827;1100.6367898593444;1169.479581586186;1189.084405008139;16734.916325418297;17920.252054631517;18976.722793264897;19193.8080619192;19328.226870925286;569443;577877;578639;581161;581560;60504.69747651234;60642;60660;60895.391046089855;61124;1363.3319673360181;1389.6317475868902;1402.305858599979;1402.4740722229164;1415.3418660323;32544.51183232301;33843.4923476153;33906.15234619154;33976.32047359089;34108.31783364368;53296.46703532915;54064.72967635294;54072.72963635156;54201.45798541964;54360.45639543554;387925;389849;393576;394978;395933;28160.873565057987;28521.714782852738;28534.714652854036;28545.857270713514;28549.42901142007;47911.520884790705;48528.272075919594;49524.75237623789;49784.502154977985;50297.24554131764;41017.384739228335;41836.58163418327;41907;43057.784711076245;43082.56917430786;40428.79785601053;40469.797651011555;40549.594504054585;41257;41817.581824182584;41007.17985640211;41152.38271425991;41291.38062929118;42605.36091958685;42640.36039459349;34971.82514087515;36283;36892.63107368892;37733.4339984906;38143.80928095453;28199.577006344512;28713;28787.5681864768;28848.42303153967;29026.7097329024 02:49:12 INFO - PROCESS | 13159 | |2;jquery.html;381.50594979501545;381.6012267180796;397.98806035818916;399.20358884026365;416.91453252083306;17986.28054877805;19050.809491905078;19688.409347719575;19702.507437314074;20329.898350508265;18870.339538116168;19370;19522.21911123557;19787.208511659515;19817.40547783565;5597.44025597441;5823.213866128082;6648.16897887764;7092.574445533284;7135.89296160558;6979.267176946424;7007.369336759691;7139;7158.033665455175;7162.176349719797;7140;7250.2024777274455;7280.344768970792;7373.188949215582;7472.701091956315;7251.528650637718;7295.978563001184;7383.630818459055;7434.293742094493;7455.776326710207;6452.7741529046725;6861.5539989901;6884.449244060514;6965.233824279325;6977.267386924351;23940.965017973493;25047.749522504724;25356.366090847692;25782.613260801103;25915.22254332373;2529.152733834168;2548.4903019396197;2636.3540932471474;2997.7451916587115;3239.3197428540034;13917.095388799797;14374;15085;15477;15868.920655396765;2069.2964392106605;2112.6302896992966;2176.9891150544304;2185.6830759539775;2210.7457642371173;90233;95094;96172.51913740457;97264;97437.61530731134;15790.36838526469;17064.48806535806;17179.484615461555;17663.911680441517;17841.821581784276;31404.685953140634;31784.68215317817;31917.20206994844;31924.521132183036;31985.680143198737;9496;9809.950950245204;9938.950305248572;10071.597136114473;10114.949425252973;7991.480553763987;8192.877106843402;8243.340532757366;8313.41806073569;8513.829723405497;8611.440256383315;8669.913300867036;8846.77883052916;8906;8969.955150224207;3272.3128143090216;3550.840212190458;3557.6442355764216;3605.603383627799;3629.582598001211;952.64752041745;973.2262851033446;984.3454103021411;1020.7448137965508;1025.154247745598;18328;19399.4180174595;19429.51426214356;19962.20151193965;20135.899320503304;1009.1825621246813;1012.2458768217725;1017.4556612212431;1034.7568321444455;1062.9468526573794;10565.418901960313;11074.778504429867;11149.944250278697;11157.721056973478;11159;433747;433791;434888;465259;475229;86644;87192;87641;89440.55279723559;90921.09078909126;978.3591747405461;978.7797745507346;1023.1712313026323;1024.861643678094;1044.5769463367349;17160.22778974974;17226.741598876277;17466.650666986334;17752.55618609545;17935.103244837966;39159.80420097881;39868.60131398649;40566.39150412687;41020.589794102874;41904.79047604743;52583.47416525786;58362.708186458796;58575.70712146583;58866.41133588609;59210.40789592049;8078.87881681787;8109.3917956152345;8379.664813407395;8402.747917562483;8422.452540584842;11475.483603237708;12173.330466824409;12353.32056736888;12509.812352814897;12593.811092833797;10116;11246.493907774333;11249.606263780728;11568.942155289169;11576.826347604961;9709.5145242739;11180.776384472427;11279.266847654877;11318.886811131782;11457.25527840721;10845.945770271413;11063.170262230204;11118.332900026024;11129.721756956142;11223.607173749206;8078.313343365645;8222.301104406193;8238.711645092393;8324.750257492286;8346.833063338821;10192.898071019195;10920.453977301262;10971.725706857393;11029.44852757343;11394.772104558027 02:49:12 INFO - PROCESS | 13159 | |3;mootools.html;1479.1689524132498;1485.3019081031914;1616.1999810094005;1731.7921849378076;1753.3337331813916;7889.999999999985;8563.529005904673;8775.6050977706;9061.184493395593;9062.728118156458;8654.307655387569;8936.061713520085;8964.058773828752;8997.95501022494;9012.098790120985;2337.55586438577;2401.4956859059616;2402.2072716003763;2403.459221675118;2407.4823912858733;2358.705161854768;2378.5718570657273;2393.700787401575;2398.124684490166;2404.4589967257402;2328.39461739948;2350.576896158691;2358.5047140100514;2361.268006917861;2389.4145934246135;2265.263789268478;2280.8403411761183;2286.199830059474;2295.391721193885;2326.6161083421216;2290.89690963907;2303.5968705476475;2318.8029017533363;2323.3494621506006;2325.2675407246834;9121.81756364869;9204.585793639302;9209.309301802325;9210.17108460235;9230.400023998418;5050.267711181858;5323.254744335796;5345.518903298683;5353.464653534655;5374;3295.9176020599675;3323.501474778778;3411.0449074259245;3449.3618680544178;3460.9826950865336;1110.1562812262657;1119.1997721628993;1147.449224372306;1155.1567355830207;1159.1190695071723;12659.430325635369;12799.912007479283;12817.269668594714;12837.165584237087;12857.228566286052;4535.727856328631;4592.678512504092;4678.485366609671;4688.132695451352;4695.859124226278;10822.945885270681;10843.891561084445;10924.399158046384;10952.507137178845;10966.122710183166;5303.7348132593215;5304.443033481506;5309.097453432925;5347;5374.3013408256675;4393.428854248928;4669.859904202879;4712.43450785901;4838.854834354975;4849.199882019498;3963.74235674686;4028.597140285948;4052.392141178788;4075.1645912587846;4075.775832329191;1332.68015676237;1348.7100273441258;1349.6490912362856;1350.1426594112809;1359.8436179839446;966.5167416291854;970.3901486470319;979.8579206015088;979.9559019844124;983.8720966274338;6049.758009679564;6072.817815465543;6249.187605611332;6273.560850740404;6422.646754428458;467.9110968915895;470.1185277604492;475.707439924444;479.8152711206141;480.59149722735395;4221.7255878367805;4319.265724826787;4339.7396156230725;4383.320585309282;4383.912321753611;10913.39976301311;11279.210455268216;11441.599544015919;11455.656330310105;11468;11021.889781102087;11200.887991119984;11305.830412543819;11310.94344528272;11349.432528373713;8348.290395316466;8391.16088391156;8404.705835295736;8453.830923381622;8498.23515883561;5910.438508341701;6033.547483938634;6087.512998959984;6102.420270074336;6211.254649442096;10123.341982771097;10402;10515.211359148247;10556.947215263874;10564.524596393334;10627.468626568796;10639.840402394126;10664.520096595517;10763.784724305626;10782.299150555189;8107.8378432429845;8152.510849349058;8161.79595510117;8210.958945205235;8216.424850260424;8567.700130495403;8585.957070214608;8599.742007739778;8672.176143266379;8746.344024198082;7803.804904877196;7879.330256928225;7900.604969751605;7950.473112630087;8134.63394147253;7669.271419215165;7727.188645192174;7863.606819658879;7880.408969327209;8081.393895457747;7102.786916392516;7303.963480182565;7327.120745510573;7361.852762944818;7382.446316526175;5336.749488569882;5426.430224826494;5433.429489903661;5489.807856725155;5561.749721262634;4979.253112033224;5197.7141257231215;5223.112070947872;5321.707306098202;5582.665040097445 02:49:12 INFO - PROCESS | 13159 | |4;prototype.html;334.1862564655065;335.59393134307487;339.6128413608487;339.6162336559686;341.59350373056077;5571.164325351199;5571.387147413786;5593.804216852411;5609.49514543691;5682.687452190128;5505.697186654733;5555.388907220213;5568;5588.385277619469;5598.0966471399715;4128.091819799647;4196.9370459443135;4306.138772245564;4347.565243475643;4375.496817865955;4323.610875021247;4352.194843953863;4353.303471444569;4355.847545335914;4390.507227542635;4315.848945286915;4361.520232774392;4379.583939525756;4384.320430333303;4391.099824535979;4223.268459931429;4332.956670433303;4337.869863904088;4349.021470169218;4350.521442641339;3839.654431101186;3848.1726428817938;3855.9807200964096;3856.595057518948;3858.401947698111;5455.772451198449;5483.396826349138;5496.725163741837;5497.862553436156;5504.944950550484;4810.494898035726;4953.950460495421;4965.950340496585;4990.251462280687;4993.650444468889;5752.971235143839;5854.326752423441;5862.882742345172;5866;5881.823545293605;4211.663066954667;4220.704550681454;4230.323148296257;4231.301835197189;4246.87457823677;5654.321481422215;6002.219711437485;6034.607750496204;6039.879202415971;6053.364396738323;4205.894852628709;4211.241976444269;4228.894277643083;4246.893827654271;4276.828926842892;4299.462567179103;4315.093830295673;4323.7621930793475;4330.935035974463;4331.328644060176;4753.548412900769;4904.215325547895;4932.679375840559;4938.629602779806;4969.527894849984;5791.594588378773;5846.766129354864;5869.388122285542;5884.735186916599;5925.288965324189;1467.3543640798014;1473.7641977283583;1489.0990950475023;1499.3253036133565;1508.2232650185163;935.8362286599954;961.7451375385529;1014.5434554450527;1019.2152042927053;1019.6380284998867;5546.750396232179;5569.888602227933;5589.74846131925;5598.916016259759;5610.270664813548;5990.670513121733;6025.78909738157;6034.456898879122;6045.78839740607;6057.3336932937345;5408.188771684278;5541.307336582927;5546.4453554644215;5606.6636001840025;5616.887662246732;3187.5218717192606;3194.3611277744544;3217.9839100804347;3242.4649932761304;3250.1874531367157;5933.497243922706;6161.229846269216;6199.132121502993;6282.277538083087;6295.685215739195;5948.553858460633;6026.7890623828835;6042.758289668364;6054;6057.939420605826;6091.939080609226;6094.379416850708;6159.969200153971;6165.352637973038;6193.783217587363;5900.940990590211;5915.349311575637;5921.378255283305;5922.170896074467;5960.940390596039;5836.824895253149;5838.357780644041;5843.2403787507355;5894;5903.760210355874;6009.879802404015;6146.508279337553;6164.537659675452;6172.444479996821;6182.938170618237;4180.310248808913;4189.266878296225;4191.497020357577;4195.643370313435;4217.768022758778;5794.62334948227;5825.9704953424825;6001.5798894077;6014.248218972629;6036.788712395045;5827.446392592867;5830.096335068071;5845.853853653693;5861.501772349398;5866.706664666664;5610.214569960127;5820.30156381237;5824.271966004249;5831.591788574759;5878.853623543368;5693.28833895763;5716.79991200306;5724.341700704473;5734.111212762028;5740.311162660508;5782.987977104074;5834.03738383179;5884.9705751470965;5890.617109887844;5926.4812454707435;5600.551955843604;5711.714864155531;5740.770369185186;5783;5818.359980402237 02:49:12 INFO - PROCESS | 13159 | |5;yui.html;750.2272659161063;769.6613490064371;778.6106946526737;813.8917424727421;837.514241739791;15077.62305942352;15422.305996230169;15468.922655386707;15524.301406436709;15719.92140039301;14301.713965720679;14365.557855164621;14471.855281447182;14492.130472171677;14815.851841481583;643.7553729582752;787.4802630264027;804.3846457460019;808.3008197908825;810.2181394953868;762.1882694929909;790.2532107158737;795.1889073145388;795.6658203554521;797.401948538596;841.5203334099566;843.3885433061013;843.8945131858518;845.4589062999685;846.6063280574532;828.842519921213;831.7421599304236;833.1460253240447;833.1834801894117;833.5540485840046;607.4077774170192;610.9938900610981;611.0132136599404;611.3428064830281;611.5994023914343;14688.779668304984;14695;14697.853021469862;14705.264736763225;14706;15325.923370383189;15428.305726242346;15596.376144954189;15621.765673514907;15902.60243493922;12354.505819767199;12461.875381246162;12554.372281385986;12748.936255318757;12825.743485130339;3887.786171760552;3962.6829853611644;4036.7174297799165;4065.471488706479;4105.651019663333;74401;74417.6279118601;75470;75498.62250688767;75767.62116189439;11481.483333250024;11599.88400115988;11624.302541847515;11796.52813887452;12136.08979326554;22331.21840735599;22559.6312387197;22618.773812261996;22654.093836246364;23228.41928951756;8532.104129066483;8594.957025214833;8767.254783343487;8809.03100658927;8908;4655.278431843002;4715.198416269242;4741.691790033637;4765.237561990065;4847.80608775645;3709.4806727058235;3818.522684664417;3824.2733880562605;3824.7513911595656;3839.3281175794123;609.1684850179473;631.2172905597026;634.6255709131634;640.9935900641027;644.4200219802216;681.7341236917606;698.2668198391668;711.3206887422499;712.1205311440367;718.6442710858054;9619.966079945814;9639.855402168972;9753.512324383752;9936.602535898483;9964.25268104895;626.2422468812788;638.2691817868607;648.5006544960354;667.1593791822241;673.4578664175386;4606.401167848158;4757.714537127784;4790.305405716152;4811.49479304668;4818.614510839125;92431;94876.52561737286;96299;110185.44907275413;110881;65490;102279;102427;103055.4847225759;103712;89572.55213723889;91599;96328;97000;97896;10047.14599259042;10063.295569310078;10198.133158681596;10279.794404112026;10345.482725863527;50558.49441505538;51246.231306529684;51708.224376633625;52024.73987630037;52599.47400525946;74625.62687186529;81730;82322.58838705768;83444;83462.58268708618;12353.505859765508;12746.808797867854;12903;13125.73748525005;13188.472461101448;14905.478308259158;14947.402103915721;14978.700425991201;15193.392264309305;15289.6177595561;13378.531751388655;14041.368138434;14042.2978851055;14495.492657756928;14504.709905801614;13383.799243011557;14182.574522764333;14285.357158928082;14307.499237526637;14871.628209294855;11155.609553665583;13626;13639.931800340935;13841.79237311421;13913.60863913641;10771.192160588143;10943.070701631192;11259.155563332619;11326.830097548378;11329.376884271443;10257;10716.464176790972;10835.620753273914;10901.83647245276;11701.414929253333 02:49:12 INFO - PROCESS | 13159 | __end_tp_report 02:49:12 INFO - PROCESS | 13159 | __start_cc_report 02:49:12 INFO - PROCESS | 13159 | _x_x_mozilla_cycle_collect,346 02:49:12 INFO - PROCESS | 13159 | __end_cc_report 02:49:12 INFO - PROCESS | 13159 | __startTimestamp1467107352577__endTimestamp 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | ------- Summary: start ------- 02:49:12 INFO - PROCESS | 13159 | Number of tests: 6 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | [#0] dojo.html Cycles:165 Average:5459.94 Median:5715.94 stddev:735.16 (12.9%) stddev-sans-first:713.80 02:49:12 INFO - PROCESS | 13159 | Values: 3103.6 3172.1 3177.8 3192.2 3202.1 5441.7 5469.4 5499.6 5505.3 5516.0 5427.5 5476.4 5503.3 5547.2 5617.1 4947.0 4984.0 5090.5 5154.9 5202.1 702.5 5071.4 5080.5 5097.2 5128.2 4949.6 4967.2 5006.9 5008.5 5011.5 4939.3 4989.6 4995.0 5020.2 5025.4 4864.5 4891.6 4901.1 4981.0 5019.8 5451.4 5534.5 5539.5 5550.5 5556.4 5908.4 5929.3 5939.9 5943.3 5945.7 5977.5 6023.1 6023.9 6032.0 6085.1 5545.2 5576.0 5586.5 5592.5 5602.7 5892.1 5893.3 5952.4 5963.6 6073.5 5799.4 5804.6 5811.9 5812.9 5822.6 5883.0 5887.6 5888.1 5918.8 5920.9 5719.1 5826.5 5859.5 5897.4 5938.6 5800.7 5887.1 5900.1 5939.2 5940.3 4523.7 4527.9 4529.5 4531.1 4566.1 3928.8 3935.5 3966.3 3991.4 4037.5 5618.9 5642.6 5659.1 5672.4 5692.0 5865.1 5930.1 5931.9 5943.3 5956.9 5447.8 5526.9 5571.9 5599.7 5643.7 4991.6 5006.9 5027.5 5054.8 5058.2 6077.3 6095.5 6120.4 6135.0 6142.0 5819.1 5855.0 5880.1 5934.1 5935.5 6164.6 6170.4 6193.6 6194.5 6208.2 5730.0 5817.5 5821.4 5825.3 5826.0 5880.7 5919.2 5923.7 5979.8 5981.3 5804.9 5826.5 5826.7 5829.5 5829.9 5630.5 5715.9 5758.3 5809.0 5809.9 5562.1 5621.9 5624.7 5651.9 5745.7 5846.4 5854.7 5855.9 5865.3 5871.4 5541.8 5576.5 5714.6 5717.2 5732.9 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | [#1] ext.html Cycles:180 Average:60078.34 Median:41827.08 stddev:118713.68 (283.8%) stddev-sans-first:118962.64 02:49:12 INFO - PROCESS | 13159 | Values: 576.0 627.4 646.7 651.6 661.2 42538.8 43867.0 43920.3 43989.8 48188.5 43596.8 44485.1 44545.1 44555.3 44674.8 8812.3 8948.1 8953.0 8953.5 8953.5 8786.5 8866.7 8875.8 8886.9 8891.7 8848.3 8870.4 8906.2 8910.8 8974.7 8872.3 8894.7 8921.2 8931.5 8935.0 8799.5 8906.7 8973.8 8979.7 8984.6 42242.4 42469.4 42533.6 42580.0 42706.0 3442.1 3487.2 3521.1 3570.6 3865.3 32851.5 33027.0 33349.8 35006.6 35076.8 4417.8 4436.6 4486.3 4502.7 4525.8 333949.0 334032.0 334651.0 335545.0 336407.0 59911.7 59933.7 60275.7 60367.4 60687.0 35867.8 36782.0 61950.0 62513.0 62733.7 16776.8 16904.6 16960.2 16989.4 17009.1 11658.3 11793.5 11814.9 11823.4 11855.1 19625.3 19695.0 19696.8 19737.0 19796.1 7181.1 7234.6 7309.6 7479.9 7489.0 1012.6 1070.8 1079.3 1128.9 1190.2 32180.8 32807.5 32885.3 32965.8 33088.3 1090.0 1096.9 1100.6 1169.5 1189.1 16734.9 17920.3 18976.7 19193.8 19328.2 569443.0 577877.0 578639.0 581161.0 581560.0 60504.7 60642.0 60660.0 60895.4 61124.0 1363.3 1389.6 1402.3 1402.5 1415.3 32544.5 33843.5 33906.2 33976.3 34108.3 53296.5 54064.7 54072.7 54201.5 54360.5 387925.0 389849.0 393576.0 394978.0 395933.0 28160.9 28521.7 28534.7 28545.9 28549.4 47911.5 48528.3 49524.8 49784.5 50297.2 41017.4 41836.6 41907.0 43057.8 43082.6 40428.8 40469.8 40549.6 41257.0 41817.6 41007.2 41152.4 41291.4 42605.4 42640.4 34971.8 36283.0 36892.6 37733.4 38143.8 28199.6 28713.0 28787.6 28848.4 29026.7 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | [#2] jquery.html Cycles:180 Average:29244.89 Median:3255.82 stddev:74297.96 (2282.0%) stddev-sans-first:74474.78 02:49:12 INFO - PROCESS | 13159 | Values: 381.5 381.6 398.0 399.2 416.9 17986.3 19050.8 19688.4 19702.5 20329.9 18870.3 19370.0 19522.2 19787.2 19817.4 5597.4 5823.2 6648.2 7092.6 7135.9 6979.3 7007.4 7139.0 7158.0 7162.2 7140.0 7250.2 7280.3 7373.2 7472.7 7251.5 7296.0 7383.6 7434.3 7455.8 6452.8 6861.6 6884.4 6965.2 6977.3 23941.0 25047.7 25356.4 25782.6 25915.2 2529.2 2548.5 2636.4 2997.7 3239.3 13917.1 14374.0 15085.0 15477.0 15868.9 2069.3 2112.6 2177.0 2185.7 2210.7 90233.0 95094.0 96172.5 97264.0 97437.6 15790.4 17064.5 17179.5 17663.9 17841.8 31404.7 31784.7 31917.2 31924.5 31985.7 9496.0 9810.0 9939.0 10071.6 10114.9 7991.5 8192.9 8243.3 8313.4 8513.8 8611.4 8669.9 8846.8 8906.0 8970.0 3272.3 3550.8 3557.6 3605.6 3629.6 952.6 973.2 984.3 1020.7 1025.2 18328.0 19399.4 19429.5 19962.2 20135.9 1009.2 1012.2 1017.5 1034.8 1062.9 10565.4 11074.8 11149.9 11157.7 11159.0 433747.0 433791.0 434888.0 465259.0 475229.0 86644.0 87192.0 87641.0 89440.6 90921.1 978.4 978.8 1023.2 1024.9 1044.6 17160.2 17226.7 17466.7 17752.6 17935.1 39159.8 39868.6 40566.4 41020.6 41904.8 52583.5 58362.7 58575.7 58866.4 59210.4 8078.9 8109.4 8379.7 8402.7 8422.5 11475.5 12173.3 12353.3 12509.8 12593.8 10116.0 11246.5 11249.6 11568.9 11576.8 9709.5 11180.8 11279.3 11318.9 11457.3 10845.9 11063.2 11118.3 11129.7 11223.6 8078.3 8222.3 8238.7 8324.8 8346.8 10192.9 10920.5 10971.7 11029.4 11394.8 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | [#3] mootools.html Cycles:180 Average:5956.56 Median:4683.31 stddev:3449.50 (73.7%) stddev-sans-first:3442.77 02:49:12 INFO - PROCESS | 13159 | Values: 1479.2 1485.3 1616.2 1731.8 1753.3 7890.0 8563.5 8775.6 9061.2 9062.7 8654.3 8936.1 8964.1 8998.0 9012.1 2337.6 2401.5 2402.2 2403.5 2407.5 2358.7 2378.6 2393.7 2398.1 2404.5 2328.4 2350.6 2358.5 2361.3 2389.4 2265.3 2280.8 2286.2 2295.4 2326.6 2290.9 2303.6 2318.8 2323.3 2325.3 9121.8 9204.6 9209.3 9210.2 9230.4 5050.3 5323.3 5345.5 5353.5 5374.0 3295.9 3323.5 3411.0 3449.4 3461.0 1110.2 1119.2 1147.4 1155.2 1159.1 12659.4 12799.9 12817.3 12837.2 12857.2 4535.7 4592.7 4678.5 4688.1 4695.9 10822.9 10843.9 10924.4 10952.5 10966.1 5303.7 5304.4 5309.1 5347.0 5374.3 4393.4 4669.9 4712.4 4838.9 4849.2 3963.7 4028.6 4052.4 4075.2 4075.8 1332.7 1348.7 1349.6 1350.1 1359.8 966.5 970.4 979.9 980.0 983.9 6049.8 6072.8 6249.2 6273.6 6422.6 467.9 470.1 475.7 479.8 480.6 4221.7 4319.3 4339.7 4383.3 4383.9 10913.4 11279.2 11441.6 11455.7 11468.0 11021.9 11200.9 11305.8 11310.9 11349.4 8348.3 8391.2 8404.7 8453.8 8498.2 5910.4 6033.5 6087.5 6102.4 6211.3 10123.3 10402.0 10515.2 10556.9 10564.5 10627.5 10639.8 10664.5 10763.8 10782.3 8107.8 8152.5 8161.8 8211.0 8216.4 8567.7 8586.0 8599.7 8672.2 8746.3 7803.8 7879.3 7900.6 7950.5 8134.6 7669.3 7727.2 7863.6 7880.4 8081.4 7102.8 7304.0 7327.1 7361.9 7382.4 5336.7 5426.4 5433.4 5489.8 5561.7 4979.3 5197.7 5223.1 5321.7 5582.7 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | [#4] prototype.html Cycles:180 Average:4906.94 Median:5595.95 stddev:1439.67 (25.7%) stddev-sans-first:1402.20 02:49:12 INFO - PROCESS | 13159 | Values: 334.2 335.6 339.6 339.6 341.6 5571.2 5571.4 5593.8 5609.5 5682.7 5505.7 5555.4 5568.0 5588.4 5598.1 4128.1 4196.9 4306.1 4347.6 4375.5 4323.6 4352.2 4353.3 4355.8 4390.5 4315.8 4361.5 4379.6 4384.3 4391.1 4223.3 4333.0 4337.9 4349.0 4350.5 3839.7 3848.2 3856.0 3856.6 3858.4 5455.8 5483.4 5496.7 5497.9 5504.9 4810.5 4954.0 4966.0 4990.3 4993.7 5753.0 5854.3 5862.9 5866.0 5881.8 4211.7 4220.7 4230.3 4231.3 4246.9 5654.3 6002.2 6034.6 6039.9 6053.4 4205.9 4211.2 4228.9 4246.9 4276.8 4299.5 4315.1 4323.8 4330.9 4331.3 4753.5 4904.2 4932.7 4938.6 4969.5 5791.6 5846.8 5869.4 5884.7 5925.3 1467.4 1473.8 1489.1 1499.3 1508.2 935.8 961.7 1014.5 1019.2 1019.6 5546.8 5569.9 5589.7 5598.9 5610.3 5990.7 6025.8 6034.5 6045.8 6057.3 5408.2 5541.3 5546.4 5606.7 5616.9 3187.5 3194.4 3218.0 3242.5 3250.2 5933.5 6161.2 6199.1 6282.3 6295.7 5948.6 6026.8 6042.8 6054.0 6057.9 6091.9 6094.4 6160.0 6165.4 6193.8 5900.9 5915.3 5921.4 5922.2 5960.9 5836.8 5838.4 5843.2 5894.0 5903.8 6009.9 6146.5 6164.5 6172.4 6182.9 4180.3 4189.3 4191.5 4195.6 4217.8 5794.6 5826.0 6001.6 6014.2 6036.8 5827.4 5830.1 5845.9 5861.5 5866.7 5610.2 5820.3 5824.3 5831.6 5878.9 5693.3 5716.8 5724.3 5734.1 5740.3 5783.0 5834.0 5885.0 5890.6 5926.5 5600.6 5711.7 5740.8 5783.0 5818.4 02:49:12 INFO - PROCESS | 13159 | 02:49:12 INFO - PROCESS | 13159 | [#5] yui.html Cycles:180 Average:20832.31 Median:4356.03 stddev:29461.05 (676.3%) stddev-sans-first:29505.11 02:49:12 INFO - PROCESS | 13159 | Values: 750.2 769.7 778.6 813.9 837.5 15077.6 15422.3 15468.9 15524.3 15719.9 14301.7 14365.6 14471.9 14492.1 14815.9 643.8 787.5 804.4 808.3 810.2 762.2 790.3 795.2 795.7 797.4 841.5 843.4 843.9 845.5 846.6 828.8 831.7 833.1 833.2 833.6 607.4 611.0 611.0 611.3 611.6 14688.8 14695.0 14697.9 14705.3 14706.0 15325.9 15428.3 15596.4 15621.8 15902.6 12354.5 12461.9 12554.4 12748.9 12825.7 3887.8 3962.7 4036.7 4065.5 4105.7 74401.0 74417.6 75470.0 75498.6 75767.6 11481.5 11599.9 11624.3 11796.5 12136.1 22331.2 22559.6 22618.8 22654.1 23228.4 8532.1 8595.0 8767.3 8809.0 8908.0 4655.3 4715.2 4741.7 4765.2 4847.8 3709.5 3818.5 3824.3 3824.8 3839.3 609.2 631.2 634.6 641.0 644.4 681.7 698.3 711.3 712.1 718.6 9620.0 9639.9 9753.5 9936.6 9964.3 626.2 638.3 648.5 667.2 673.5 4606.4 4757.7 4790.3 4811.5 4818.6 92431.0 94876.5 96299.0 110185.4 110881.0 65490.0 102279.0 102427.0 103055.5 103712.0 89572.6 91599.0 96328.0 97000.0 97896.0 10047.1 10063.3 10198.1 10279.8 10345.5 50558.5 51246.2 51708.2 52024.7 52599.5 74625.6 81730.0 82322.6 83444.0 83462.6 12353.5 12746.8 12903.0 13125.7 13188.5 14905.5 14947.4 14978.7 15193.4 15289.6 13378.5 14041.4 14042.3 14495.5 14504.7 13383.8 14182.6 14285.4 14307.5 14871.6 11155.6 13626.0 13639.9 13841.8 13913.6 10771.2 10943.1 11259.2 11326.8 11329.4 10257.0 10716.5 10835.6 10901.8 11701.4 02:49:12 INFO - PROCESS | 13159 | -------- Summary: end -------- 02:49:12 INFO - PROCESS | 13159 | 02:49:13 INFO - TEST-INFO | 13159: exit 0 02:49:13 INFO - TEST-OK | dromaeo_css | took 1110627ms 02:49:13 INFO - TEST-START | kraken 02:49:13 INFO - operating with platform_type : linux_ 02:49:13 INFO - Initialising browser for kraken test... 02:49:13 INFO - TEST-INFO | started process 13394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6z8Yzm/profile http://localhost:36019/getInfo.html) 02:49:17 INFO - PROCESS | 13394 | __metrics Screen width/height:1600/1200 02:49:17 INFO - PROCESS | 13394 | colorDepth:24 02:49:17 INFO - PROCESS | 13394 | Browser inner width/height: 1024/697 02:49:17 INFO - PROCESS | 13394 | __metrics 02:49:17 ERROR - PROCESS | 13394 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:49:18 INFO - TEST-INFO | 13394: exit 0 02:49:18 INFO - Browser initialized. 02:49:18 INFO - Running cycle 1/1 for kraken test... 02:49:18 INFO - TEST-INFO | started process 13518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6z8Yzm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:30 INFO - PROCESS | 13518 | RSS: Main: 167710720 02:49:30 INFO - PROCESS | 13518 | 02:49:32 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36019/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:33 INFO - PROCESS | 13518 | RSS: Main: 173383680 02:49:33 INFO - PROCESS | 13518 | 02:49:36 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36019/tests/kraken/driver.html?testName=audio-dft) 02:49:37 INFO - PROCESS | 13518 | RSS: Main: 172896256 02:49:37 INFO - PROCESS | 13518 | 02:49:40 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36019/tests/kraken/driver.html?testName=audio-fft) 02:49:40 INFO - PROCESS | 13518 | RSS: Main: 167260160 02:49:40 INFO - PROCESS | 13518 | 02:49:42 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36019/tests/kraken/driver.html?testName=audio-oscillator) 02:49:43 INFO - PROCESS | 13518 | RSS: Main: 168116224 02:49:43 INFO - PROCESS | 13518 | 02:49:45 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36019/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:46 INFO - PROCESS | 13518 | RSS: Main: 168849408 02:49:46 INFO - PROCESS | 13518 | 02:49:49 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36019/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:50 INFO - PROCESS | 13518 | RSS: Main: 169234432 02:49:50 INFO - PROCESS | 13518 | 02:49:53 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36019/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:54 INFO - PROCESS | 13518 | RSS: Main: 169291776 02:49:54 INFO - PROCESS | 13518 | 02:49:56 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36019/tests/kraken/driver.html?testName=json-parse-financial) 02:49:57 INFO - PROCESS | 13518 | RSS: Main: 169091072 02:49:57 INFO - PROCESS | 13518 | 02:49:59 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36019/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:49:59 INFO - PROCESS | 13518 | RSS: Main: 169250816 02:49:59 INFO - PROCESS | 13518 | 02:50:01 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:02 INFO - PROCESS | 13518 | RSS: Main: 169123840 02:50:02 INFO - PROCESS | 13518 | 02:50:04 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:04 INFO - PROCESS | 13518 | RSS: Main: 170201088 02:50:04 INFO - PROCESS | 13518 | 02:50:07 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:08 INFO - PROCESS | 13518 | RSS: Main: 170037248 02:50:08 INFO - PROCESS | 13518 | 02:50:10 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:11 INFO - PROCESS | 13518 | RSS: Main: 169803776 02:50:11 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | Cycle 1(1): loaded http://localhost:36019/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36019/tests/kraken/driver.html?testName=ai-astar) 02:50:13 INFO - PROCESS | 13518 | RSS: Main: 170381312 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | __start_tp_report 02:50:13 INFO - PROCESS | 13518 | _x_x_mozilla_page_load 02:50:13 INFO - PROCESS | 13518 | _x_x_mozilla_page_load_details 02:50:13 INFO - PROCESS | 13518 | |i|pagename|runs| 02:50:13 INFO - PROCESS | 13518 | |0;ai-astar;101;110;105;111;111;111;113;110;109;110 02:50:13 INFO - PROCESS | 13518 | |1;audio-beat-detection;163;126;152;192;127;158;162;136;186;128 02:50:13 INFO - PROCESS | 13518 | |2;audio-dft;163;165;162;164;164;166;167;165;163;163 02:50:13 INFO - PROCESS | 13518 | |3;audio-fft;75;76;76;157;82;77;75;75;164;77 02:50:13 INFO - PROCESS | 13518 | |4;audio-oscillator;86;86;156;85;85;85;144;85;86;151 02:50:13 INFO - PROCESS | 13518 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;117;120;117 02:50:13 INFO - PROCESS | 13518 | |6;imaging-darkroom;147;147;149;147;149;148;147;146;147;147 02:50:13 INFO - PROCESS | 13518 | |7;imaging-desaturate;95;97;96;96;95;96;96;95;96;96 02:50:13 INFO - PROCESS | 13518 | |8;json-parse-financial;58;58;57;60;59;60;56;58;57;60 02:50:13 INFO - PROCESS | 13518 | |9;json-stringify-tinderbox;65;61;62;61;61;60;61;61;62;62 02:50:13 INFO - PROCESS | 13518 | |10;stanford-crypto-aes;79;79;79;79;79;80;85;81;92;83 02:50:13 INFO - PROCESS | 13518 | |11;stanford-crypto-ccm;126;126;129;134;134;129;124;127;126;131 02:50:13 INFO - PROCESS | 13518 | |12;stanford-crypto-pbkdf2;159;162;163;163;164;158;168;160;164;166 02:50:13 INFO - PROCESS | 13518 | |13;stanford-crypto-sha256-iterative;65;64;64;62;64;62;65;62;62;62 02:50:13 INFO - PROCESS | 13518 | __end_tp_report 02:50:13 INFO - PROCESS | 13518 | __start_cc_report 02:50:13 INFO - PROCESS | 13518 | _x_x_mozilla_cycle_collect,861 02:50:13 INFO - PROCESS | 13518 | __end_cc_report 02:50:13 INFO - PROCESS | 13518 | __startTimestamp1467107413366__endTimestamp 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | ------- Summary: start ------- 02:50:13 INFO - PROCESS | 13518 | Number of tests: 14 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.51 (3.2%) stddev-sans-first:2.18 02:50:13 INFO - PROCESS | 13518 | Values: 101.0 110.0 105.0 111.0 111.0 111.0 113.0 110.0 109.0 110.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:160.00 stddev:23.89 (14.9%) stddev-sans-first:25.06 02:50:13 INFO - PROCESS | 13518 | Values: 163.0 126.0 152.0 192.0 127.0 158.0 162.0 136.0 186.0 128.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:1.55 (0.9%) stddev-sans-first:1.58 02:50:13 INFO - PROCESS | 13518 | Values: 163.0 165.0 162.0 164.0 164.0 166.0 167.0 165.0 163.0 163.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:35.46 (46.7%) stddev-sans-first:36.98 02:50:13 INFO - PROCESS | 13518 | Values: 75.0 76.0 76.0 157.0 82.0 77.0 75.0 75.0 164.0 77.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:85.00 stddev:31.48 (37.0%) stddev-sans-first:32.64 02:50:13 INFO - PROCESS | 13518 | Values: 86.0 86.0 156.0 85.0 85.0 85.0 144.0 85.0 86.0 151.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 02:50:13 INFO - PROCESS | 13518 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 120.0 117.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 02:50:13 INFO - PROCESS | 13518 | Values: 147.0 147.0 149.0 147.0 149.0 148.0 147.0 146.0 147.0 147.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 02:50:13 INFO - PROCESS | 13518 | Values: 95.0 97.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.50 stddev:1.42 (2.4%) stddev-sans-first:1.50 02:50:13 INFO - PROCESS | 13518 | Values: 58.0 58.0 57.0 60.0 59.0 60.0 56.0 58.0 57.0 60.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.50 stddev:1.35 (2.2%) stddev-sans-first:0.67 02:50:13 INFO - PROCESS | 13518 | Values: 65.0 61.0 62.0 61.0 61.0 60.0 61.0 61.0 62.0 62.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:4.20 (5.2%) stddev-sans-first:4.34 02:50:13 INFO - PROCESS | 13518 | Values: 79.0 79.0 79.0 79.0 79.0 80.0 85.0 81.0 92.0 83.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:129.00 stddev:3.47 (2.7%) stddev-sans-first:3.55 02:50:13 INFO - PROCESS | 13518 | Values: 126.0 126.0 129.0 134.0 134.0 129.0 124.0 127.0 126.0 131.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.70 Median:163.50 stddev:3.09 (1.9%) stddev-sans-first:2.98 02:50:13 INFO - PROCESS | 13518 | Values: 159.0 162.0 163.0 163.0 164.0 158.0 168.0 160.0 164.0 166.0 02:50:13 INFO - PROCESS | 13518 | 02:50:13 INFO - PROCESS | 13518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:64.00 stddev:1.32 (2.1%) stddev-sans-first:1.22 02:50:13 INFO - PROCESS | 13518 | Values: 65.0 64.0 64.0 62.0 64.0 62.0 65.0 62.0 62.0 62.0 02:50:13 INFO - PROCESS | 13518 | -------- Summary: end -------- 02:50:13 INFO - PROCESS | 13518 | 02:50:14 INFO - TEST-INFO | 13518: exit 0 02:50:14 INFO - TEST-OK | kraken | took 61016ms 02:50:14 INFO - SUITE-END | took 1171s 02:50:14 INFO - Completed test suite (00:19:31) 02:50:14 INFO - javascript benchmark 02:50:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7515.063831126237, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.596532450782, 3172.0642410488904, 3177.7934434261765, 3192.2338638726696, 3202.0553936588703, 5441.673499590022, 5469.398366179722, 5499.587530935176, 5505.311836020497, 5515.972420137899, 5427.511523962842, 5476.4249753775875, 5503.3120859892515, 5547.195656629786, 5617.0731829248125, 4947.0, 4983.975080124595, 5090.490950904898, 5154.92267615986, 5202.089634313998, 702.5484117897797, 5071.442141364447, 5080.466551012146, 5097.23541468779, 5128.153854613985, 4949.604031677457, 4967.205247160437, 5006.874828129307, 5008.499150084999, 5011.523905229015, 4939.333190019337, 4989.57588604969, 4994.9750251248515, 5020.221865610836, 5025.3718285214345, 4864.537868902448, 4891.584215341701, 4901.1177987962155, 4981.0, 5019.824306149304, 5451.427600101972, 5534.529564986981, 5539.473749993744, 5550.47270509301, 5556.416576259516, 5908.4091590841, 5929.347771745104, 5939.910901336483, 5943.286805583314, 5945.702714864239, 5977.521798256129, 6023.066424704178, 6023.879522409527, 6031.969840150815, 6085.117657939618, 5545.168224766277, 5575.996320662279, 5586.469285417838, 5592.5246354059545, 5602.719864006784, 5892.057270836645, 5893.3222679391565, 5952.404759524013, 5963.582549221513, 6073.51411887048, 5799.449052340021, 5804.593678442468, 5811.854703632358, 5812.88374232513, 5822.563307751935, 5882.970585147047, 5887.646741195542, 5888.116782482662, 5918.763249470059, 5920.940790592125, 5719.113537401709, 5826.504747096459, 5859.472647461749, 5897.380775018647, 5938.554608404387, 5800.709964501758, 5887.0580707086665, 5900.055991041413, 5939.22790037301, 5940.257467816523, 4523.683342166082, 4527.886802829956, 4529.524399937959, 4531.13908357411, 4566.06395688883, 3928.7839168845417, 3935.5080614923136, 3966.3257246268204, 3991.4012898064943, 4037.4953130858644, 5618.943810561842, 5642.576806739511, 5659.094544872883, 5672.432756724377, 5692.0, 5865.090910908816, 5930.11048342752, 5931.851703707355, 5943.257092863392, 5956.851078723066, 5447.836564903059, 5526.861828454241, 5571.8885622288135, 5599.720013999366, 5643.746031428595, 4991.625628077909, 5006.899862002812, 5027.472115427828, 5054.797808087709, 5058.190689489737, 6077.265825799587, 6095.455447509409, 6120.416658367975, 6134.957077260912, 6141.986572215535, 5819.098039803753, 5855.03391940325, 5880.14737863016, 5934.139549765347, 5935.525157987437, 6164.568480206342, 6170.444659980623, 6193.628382297076, 6194.5044396449075, 6208.2239720034995, 5729.9713501432225, 5817.5345972321265, 5821.359650438364, 5825.300963884361, 5825.970870145622, 5880.705964701833, 5919.171316015675, 5923.703814809156, 5979.820605381671, 5981.3420523743225, 5804.854878628068, 5826.475617194473, 5826.73779679907, 5829.475347218601, 5829.912551311649, 5630.493255607015, 5715.942840571707, 5758.2514273144225, 5809.041508151107, 5809.883802323845, 5562.054450743464, 5621.9156712650165, 5624.6625202487985, 5651.88696226065, 5745.741441635053, 5846.35690074083, 5854.736536855767, 5855.882882342415, 5865.266841644794, 5871.383504731942, 5541.778328866962, 5576.498115169654, 5714.628549144292, 5717.1995920570325, 5732.9394062098645], "value": 5411.598896017149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9568032397572, 627.375761117688, 646.7219095788809, 651.5829868883915, 661.2032500836492, 42538.78730606347, 43867.0, 43920.3411948821, 43989.78005109978, 48188.51811481884, 43596.78201608996, 44485.110297794025, 44545.10909781802, 44555.33167002498, 44674.77662611682, 8812.295016398704, 8948.149925757076, 8952.955235223848, 8953.462792232454, 8953.507557084391, 8786.472811631322, 8866.689665861697, 8875.822483550324, 8886.86669699955, 8891.73324800257, 8848.292136629087, 8870.37907346486, 8906.24296934758, 8910.777230569256, 8974.685885993991, 8872.334574906909, 8894.688685895962, 8921.197092261695, 8931.50876701781, 8935.0, 8799.516026618534, 8906.688265910727, 8973.820523589491, 8979.730608081769, 8984.640614375417, 42242.36636450456, 42469.362959555634, 42533.57466425327, 42580.0, 42706.0, 3442.1394651337164, 3487.2153765402836, 3521.1197200699826, 3570.625084366156, 3865.3042452358563, 32851.50722739161, 33027.0, 33349.833250833835, 35006.649933500594, 35076.82461587676, 4417.845375411877, 4436.622887054604, 4486.282194848841, 4502.707324023928, 4525.841595544173, 333949.0, 334032.0, 334651.0, 335545.0, 336407.0, 59911.700441497516, 59933.700331498934, 60275.69862150661, 60367.39632603706, 60687.0, 35867.82066089653, 36782.0, 61950.0, 62513.0, 62733.68633156805, 16776.83223167777, 16904.56311213536, 16960.15199240033, 16989.40537081196, 17009.064501452292, 11658.300501969909, 11793.528258869721, 11814.94092529532, 11823.408829558488, 11855.110866685032, 19625.31311404094, 19695.01524923748, 19696.803031969783, 19737.0, 19796.109175087156, 7181.138263408425, 7234.625421169961, 7309.634518274065, 7479.8504029919095, 7488.962555187298, 1012.5747186181821, 1070.7590792071878, 1079.3038490173794, 1128.8701799293021, 1190.2441949362044, 32180.83909580437, 32807.50788738171, 32885.342293154004, 32965.83517082399, 33088.3382332352, 1090.0407641275626, 1096.8628921384827, 1100.6367898593444, 1169.479581586186, 1189.084405008139, 16734.916325418297, 17920.252054631517, 18976.722793264897, 19193.8080619192, 19328.226870925286, 569443.0, 577877.0, 578639.0, 581161.0, 581560.0, 60504.69747651234, 60642.0, 60660.0, 60895.391046089855, 61124.0, 1363.3319673360181, 1389.6317475868902, 1402.305858599979, 1402.4740722229164, 1415.3418660323, 32544.51183232301, 33843.4923476153, 33906.15234619154, 33976.32047359089, 34108.31783364368, 53296.46703532915, 54064.72967635294, 54072.72963635156, 54201.45798541964, 54360.45639543554, 387925.0, 389849.0, 393576.0, 394978.0, 395933.0, 28160.873565057987, 28521.714782852738, 28534.714652854036, 28545.857270713514, 28549.42901142007, 47911.520884790705, 48528.272075919594, 49524.75237623789, 49784.502154977985, 50297.24554131764, 41017.384739228335, 41836.58163418327, 41907.0, 43057.784711076245, 43082.56917430786, 40428.79785601053, 40469.797651011555, 40549.594504054585, 41257.0, 41817.581824182584, 41007.17985640211, 41152.38271425991, 41291.38062929118, 42605.36091958685, 42640.36039459349, 34971.82514087515, 36283.0, 36892.63107368892, 37733.4339984906, 38143.80928095453, 28199.577006344512, 28713.0, 28787.5681864768, 28848.42303153967, 29026.7097329024], "value": 20384.855411114153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.50594979501545, 381.6012267180796, 397.98806035818916, 399.20358884026365, 416.91453252083306, 17986.28054877805, 19050.809491905078, 19688.409347719575, 19702.507437314074, 20329.898350508265, 18870.339538116168, 19370.0, 19522.21911123557, 19787.208511659515, 19817.40547783565, 5597.44025597441, 5823.213866128082, 6648.16897887764, 7092.574445533284, 7135.89296160558, 6979.267176946424, 7007.369336759691, 7139.0, 7158.033665455175, 7162.176349719797, 7140.0, 7250.2024777274455, 7280.344768970792, 7373.188949215582, 7472.701091956315, 7251.528650637718, 7295.978563001184, 7383.630818459055, 7434.293742094493, 7455.776326710207, 6452.7741529046725, 6861.5539989901, 6884.449244060514, 6965.233824279325, 6977.267386924351, 23940.965017973493, 25047.749522504724, 25356.366090847692, 25782.613260801103, 25915.22254332373, 2529.152733834168, 2548.4903019396197, 2636.3540932471474, 2997.7451916587115, 3239.3197428540034, 13917.095388799797, 14374.0, 15085.0, 15477.0, 15868.920655396765, 2069.2964392106605, 2112.6302896992966, 2176.9891150544304, 2185.6830759539775, 2210.7457642371173, 90233.0, 95094.0, 96172.51913740457, 97264.0, 97437.61530731134, 15790.36838526469, 17064.48806535806, 17179.484615461555, 17663.911680441517, 17841.821581784276, 31404.685953140634, 31784.68215317817, 31917.20206994844, 31924.521132183036, 31985.680143198737, 9496.0, 9809.950950245204, 9938.950305248572, 10071.597136114473, 10114.949425252973, 7991.480553763987, 8192.877106843402, 8243.340532757366, 8313.41806073569, 8513.829723405497, 8611.440256383315, 8669.913300867036, 8846.77883052916, 8906.0, 8969.955150224207, 3272.3128143090216, 3550.840212190458, 3557.6442355764216, 3605.603383627799, 3629.582598001211, 952.64752041745, 973.2262851033446, 984.3454103021411, 1020.7448137965508, 1025.154247745598, 18328.0, 19399.4180174595, 19429.51426214356, 19962.20151193965, 20135.899320503304, 1009.1825621246813, 1012.2458768217725, 1017.4556612212431, 1034.7568321444455, 1062.9468526573794, 10565.418901960313, 11074.778504429867, 11149.944250278697, 11157.721056973478, 11159.0, 433747.0, 433791.0, 434888.0, 465259.0, 475229.0, 86644.0, 87192.0, 87641.0, 89440.55279723559, 90921.09078909126, 978.3591747405461, 978.7797745507346, 1023.1712313026323, 1024.861643678094, 1044.5769463367349, 17160.22778974974, 17226.741598876277, 17466.650666986334, 17752.55618609545, 17935.103244837966, 39159.80420097881, 39868.60131398649, 40566.39150412687, 41020.589794102874, 41904.79047604743, 52583.47416525786, 58362.708186458796, 58575.70712146583, 58866.41133588609, 59210.40789592049, 8078.87881681787, 8109.3917956152345, 8379.664813407395, 8402.747917562483, 8422.452540584842, 11475.483603237708, 12173.330466824409, 12353.32056736888, 12509.812352814897, 12593.811092833797, 10116.0, 11246.493907774333, 11249.606263780728, 11568.942155289169, 11576.826347604961, 9709.5145242739, 11180.776384472427, 11279.266847654877, 11318.886811131782, 11457.25527840721, 10845.945770271413, 11063.170262230204, 11118.332900026024, 11129.721756956142, 11223.607173749206, 8078.313343365645, 8222.301104406193, 8238.711645092393, 8324.750257492286, 8346.833063338821, 10192.898071019195, 10920.453977301262, 10971.725706857393, 11029.44852757343, 11394.772104558027], "value": 10335.878776707383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.1689524132498, 1485.3019081031914, 1616.1999810094005, 1731.7921849378076, 1753.3337331813916, 7889.999999999985, 8563.529005904673, 8775.6050977706, 9061.184493395593, 9062.728118156458, 8654.307655387569, 8936.061713520085, 8964.058773828752, 8997.95501022494, 9012.098790120985, 2337.55586438577, 2401.4956859059616, 2402.2072716003763, 2403.459221675118, 2407.4823912858733, 2358.705161854768, 2378.5718570657273, 2393.700787401575, 2398.124684490166, 2404.4589967257402, 2328.39461739948, 2350.576896158691, 2358.5047140100514, 2361.268006917861, 2389.4145934246135, 2265.263789268478, 2280.8403411761183, 2286.199830059474, 2295.391721193885, 2326.6161083421216, 2290.89690963907, 2303.5968705476475, 2318.8029017533363, 2323.3494621506006, 2325.2675407246834, 9121.81756364869, 9204.585793639302, 9209.309301802325, 9210.17108460235, 9230.400023998418, 5050.267711181858, 5323.254744335796, 5345.518903298683, 5353.464653534655, 5374.0, 3295.9176020599675, 3323.501474778778, 3411.0449074259245, 3449.3618680544178, 3460.9826950865336, 1110.1562812262657, 1119.1997721628993, 1147.449224372306, 1155.1567355830207, 1159.1190695071723, 12659.430325635369, 12799.912007479283, 12817.269668594714, 12837.165584237087, 12857.228566286052, 4535.727856328631, 4592.678512504092, 4678.485366609671, 4688.132695451352, 4695.859124226278, 10822.945885270681, 10843.891561084445, 10924.399158046384, 10952.507137178845, 10966.122710183166, 5303.7348132593215, 5304.443033481506, 5309.097453432925, 5347.0, 5374.3013408256675, 4393.428854248928, 4669.859904202879, 4712.43450785901, 4838.854834354975, 4849.199882019498, 3963.74235674686, 4028.597140285948, 4052.392141178788, 4075.1645912587846, 4075.775832329191, 1332.68015676237, 1348.7100273441258, 1349.6490912362856, 1350.1426594112809, 1359.8436179839446, 966.5167416291854, 970.3901486470319, 979.8579206015088, 979.9559019844124, 983.8720966274338, 6049.758009679564, 6072.817815465543, 6249.187605611332, 6273.560850740404, 6422.646754428458, 467.9110968915895, 470.1185277604492, 475.707439924444, 479.8152711206141, 480.59149722735395, 4221.7255878367805, 4319.265724826787, 4339.7396156230725, 4383.320585309282, 4383.912321753611, 10913.39976301311, 11279.210455268216, 11441.599544015919, 11455.656330310105, 11468.0, 11021.889781102087, 11200.887991119984, 11305.830412543819, 11310.94344528272, 11349.432528373713, 8348.290395316466, 8391.16088391156, 8404.705835295736, 8453.830923381622, 8498.23515883561, 5910.438508341701, 6033.547483938634, 6087.512998959984, 6102.420270074336, 6211.254649442096, 10123.341982771097, 10402.0, 10515.211359148247, 10556.947215263874, 10564.524596393334, 10627.468626568796, 10639.840402394126, 10664.520096595517, 10763.784724305626, 10782.299150555189, 8107.8378432429845, 8152.510849349058, 8161.79595510117, 8210.958945205235, 8216.424850260424, 8567.700130495403, 8585.957070214608, 8599.742007739778, 8672.176143266379, 8746.344024198082, 7803.804904877196, 7879.330256928225, 7900.604969751605, 7950.473112630087, 8134.63394147253, 7669.271419215165, 7727.188645192174, 7863.606819658879, 7880.408969327209, 8081.393895457747, 7102.786916392516, 7303.963480182565, 7327.120745510573, 7361.852762944818, 7382.446316526175, 5336.749488569882, 5426.430224826494, 5433.429489903661, 5489.807856725155, 5561.749721262634, 4979.253112033224, 5197.7141257231215, 5223.112070947872, 5321.707306098202, 5582.665040097445], "value": 4667.542829591757, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.1862564655065, 335.59393134307487, 339.6128413608487, 339.6162336559686, 341.59350373056077, 5571.164325351199, 5571.387147413786, 5593.804216852411, 5609.49514543691, 5682.687452190128, 5505.697186654733, 5555.388907220213, 5568.0, 5588.385277619469, 5598.0966471399715, 4128.091819799647, 4196.9370459443135, 4306.138772245564, 4347.565243475643, 4375.496817865955, 4323.610875021247, 4352.194843953863, 4353.303471444569, 4355.847545335914, 4390.507227542635, 4315.848945286915, 4361.520232774392, 4379.583939525756, 4384.320430333303, 4391.099824535979, 4223.268459931429, 4332.956670433303, 4337.869863904088, 4349.021470169218, 4350.521442641339, 3839.654431101186, 3848.1726428817938, 3855.9807200964096, 3856.595057518948, 3858.401947698111, 5455.772451198449, 5483.396826349138, 5496.725163741837, 5497.862553436156, 5504.944950550484, 4810.494898035726, 4953.950460495421, 4965.950340496585, 4990.251462280687, 4993.650444468889, 5752.971235143839, 5854.326752423441, 5862.882742345172, 5866.0, 5881.823545293605, 4211.663066954667, 4220.704550681454, 4230.323148296257, 4231.301835197189, 4246.87457823677, 5654.321481422215, 6002.219711437485, 6034.607750496204, 6039.879202415971, 6053.364396738323, 4205.894852628709, 4211.241976444269, 4228.894277643083, 4246.893827654271, 4276.828926842892, 4299.462567179103, 4315.093830295673, 4323.7621930793475, 4330.935035974463, 4331.328644060176, 4753.548412900769, 4904.215325547895, 4932.679375840559, 4938.629602779806, 4969.527894849984, 5791.594588378773, 5846.766129354864, 5869.388122285542, 5884.735186916599, 5925.288965324189, 1467.3543640798014, 1473.7641977283583, 1489.0990950475023, 1499.3253036133565, 1508.2232650185163, 935.8362286599954, 961.7451375385529, 1014.5434554450527, 1019.2152042927053, 1019.6380284998867, 5546.750396232179, 5569.888602227933, 5589.74846131925, 5598.916016259759, 5610.270664813548, 5990.670513121733, 6025.78909738157, 6034.456898879122, 6045.78839740607, 6057.3336932937345, 5408.188771684278, 5541.307336582927, 5546.4453554644215, 5606.6636001840025, 5616.887662246732, 3187.5218717192606, 3194.3611277744544, 3217.9839100804347, 3242.4649932761304, 3250.1874531367157, 5933.497243922706, 6161.229846269216, 6199.132121502993, 6282.277538083087, 6295.685215739195, 5948.553858460633, 6026.7890623828835, 6042.758289668364, 6054.0, 6057.939420605826, 6091.939080609226, 6094.379416850708, 6159.969200153971, 6165.352637973038, 6193.783217587363, 5900.940990590211, 5915.349311575637, 5921.378255283305, 5922.170896074467, 5960.940390596039, 5836.824895253149, 5838.357780644041, 5843.2403787507355, 5894.0, 5903.760210355874, 6009.879802404015, 6146.508279337553, 6164.537659675452, 6172.444479996821, 6182.938170618237, 4180.310248808913, 4189.266878296225, 4191.497020357577, 4195.643370313435, 4217.768022758778, 5794.62334948227, 5825.9704953424825, 6001.5798894077, 6014.248218972629, 6036.788712395045, 5827.446392592867, 5830.096335068071, 5845.853853653693, 5861.501772349398, 5866.706664666664, 5610.214569960127, 5820.30156381237, 5824.271966004249, 5831.591788574759, 5878.853623543368, 5693.28833895763, 5716.79991200306, 5724.341700704473, 5734.111212762028, 5740.311162660508, 5782.987977104074, 5834.03738383179, 5884.9705751470965, 5890.617109887844, 5926.4812454707435, 5600.551955843604, 5711.714864155531, 5740.770369185186, 5783.0, 5818.359980402237], "value": 4444.318135247927, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2272659161063, 769.6613490064371, 778.6106946526737, 813.8917424727421, 837.514241739791, 15077.62305942352, 15422.305996230169, 15468.922655386707, 15524.301406436709, 15719.92140039301, 14301.713965720679, 14365.557855164621, 14471.855281447182, 14492.130472171677, 14815.851841481583, 643.7553729582752, 787.4802630264027, 804.3846457460019, 808.3008197908825, 810.2181394953868, 762.1882694929909, 790.2532107158737, 795.1889073145388, 795.6658203554521, 797.401948538596, 841.5203334099566, 843.3885433061013, 843.8945131858518, 845.4589062999685, 846.6063280574532, 828.842519921213, 831.7421599304236, 833.1460253240447, 833.1834801894117, 833.5540485840046, 607.4077774170192, 610.9938900610981, 611.0132136599404, 611.3428064830281, 611.5994023914343, 14688.779668304984, 14695.0, 14697.853021469862, 14705.264736763225, 14706.0, 15325.923370383189, 15428.305726242346, 15596.376144954189, 15621.765673514907, 15902.60243493922, 12354.505819767199, 12461.875381246162, 12554.372281385986, 12748.936255318757, 12825.743485130339, 3887.786171760552, 3962.6829853611644, 4036.7174297799165, 4065.471488706479, 4105.651019663333, 74401.0, 74417.6279118601, 75470.0, 75498.62250688767, 75767.62116189439, 11481.483333250024, 11599.88400115988, 11624.302541847515, 11796.52813887452, 12136.08979326554, 22331.21840735599, 22559.6312387197, 22618.773812261996, 22654.093836246364, 23228.41928951756, 8532.104129066483, 8594.957025214833, 8767.254783343487, 8809.03100658927, 8908.0, 4655.278431843002, 4715.198416269242, 4741.691790033637, 4765.237561990065, 4847.80608775645, 3709.4806727058235, 3818.522684664417, 3824.2733880562605, 3824.7513911595656, 3839.3281175794123, 609.1684850179473, 631.2172905597026, 634.6255709131634, 640.9935900641027, 644.4200219802216, 681.7341236917606, 698.2668198391668, 711.3206887422499, 712.1205311440367, 718.6442710858054, 9619.966079945814, 9639.855402168972, 9753.512324383752, 9936.602535898483, 9964.25268104895, 626.2422468812788, 638.2691817868607, 648.5006544960354, 667.1593791822241, 673.4578664175386, 4606.401167848158, 4757.714537127784, 4790.305405716152, 4811.49479304668, 4818.614510839125, 92431.0, 94876.52561737286, 96299.0, 110185.44907275413, 110881.0, 65490.0, 102279.0, 102427.0, 103055.4847225759, 103712.0, 89572.55213723889, 91599.0, 96328.0, 97000.0, 97896.0, 10047.14599259042, 10063.295569310078, 10198.133158681596, 10279.794404112026, 10345.482725863527, 50558.49441505538, 51246.231306529684, 51708.224376633625, 52024.73987630037, 52599.47400525946, 74625.62687186529, 81730.0, 82322.58838705768, 83444.0, 83462.58268708618, 12353.505859765508, 12746.808797867854, 12903.0, 13125.73748525005, 13188.472461101448, 14905.478308259158, 14947.402103915721, 14978.700425991201, 15193.392264309305, 15289.6177595561, 13378.531751388655, 14041.368138434, 14042.2978851055, 14495.492657756928, 14504.709905801614, 13383.799243011557, 14182.574522764333, 14285.357158928082, 14307.499237526637, 14871.628209294855, 11155.609553665583, 13626.0, 13639.931800340935, 13841.79237311421, 13913.60863913641, 10771.192160588143, 10943.070701631192, 11259.155563332619, 11326.830097548378, 11329.376884271443, 10257.0, 10716.464176790972, 10835.620753273914, 10901.83647245276, 11701.414929253333], "value": 7615.1301383177, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 105.0, 111.0, 111.0, 111.0, 113.0, 110.0, 109.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 152.0, 192.0, 127.0, 158.0, 162.0, 136.0, 186.0, 128.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 164.0, 164.0, 166.0, 167.0, 165.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 157.0, 82.0, 77.0, 75.0, 75.0, 164.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 156.0, 85.0, 85.0, 85.0, 144.0, 85.0, 86.0, 151.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 120.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 149.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 60.0, 59.0, 60.0, 56.0, 58.0, 57.0, 60.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 85.0, 81.0, 92.0, 83.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 129.0, 134.0, 134.0, 129.0, 124.0, 127.0, 126.0, 131.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 163.0, 163.0, 164.0, 158.0, 168.0, 160.0, 164.0, 166.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 62.0, 64.0, 62.0, 65.0, 62.0, 62.0, 62.0], "value": 63.2, "unit": "score"}]}]} 02:50:14 INFO - Return code: 0 02:50:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:50:14 ERROR - # TBPL SUCCESS # 02:50:14 INFO - Running post-action listener: _resource_record_post_action 02:50:14 INFO - ##### 02:50:14 INFO - ##### Finished run-tests step (success) 02:50:14 INFO - ##### 02:50:14 INFO - Running post-run listener: _resource_record_post_run 02:50:14 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 482263040; Read time: 200; Write time: 425428 02:50:14 INFO - TinderboxPrint: CPU usage
13.5% 02:50:14 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 200 02:50:14 INFO - TinderboxPrint: I/O write bytes / time
482,263,040 / 425,428 02:50:14 INFO - TinderboxPrint: CPU idle
8,215.6 (86.5%) 02:50:14 INFO - TinderboxPrint: CPU user
1,224.4 (12.9%) 02:50:14 INFO - TinderboxPrint: Swap in / out
0 / 0 02:50:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 181927936; Read time: 0; Write time: 188112 02:50:14 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 12288; Write bytes: 300335104; Read time: 200; Write time: 237316 02:50:15 INFO - Running post-run listener: _upload_blobber_files 02:50:15 INFO - Blob upload gear active. 02:50:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:50:15 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:50:15 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:50:15 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:50:15 INFO - (blobuploader) - INFO - Open directory for files ... 02:50:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:50:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:19 INFO - (blobuploader) - INFO - Done attempting. 02:50:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:50:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:19 INFO - (blobuploader) - INFO - Done attempting. 02:50:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:50:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:50:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:20 INFO - (blobuploader) - INFO - Done attempting. 02:50:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:50:20 INFO - Return code: 0 02:50:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:50:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:50:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d9d8ed4bfce07a9b54a26384325fd39518910bd87168d8bdfd6607c5d3c2be1bca7aef51b74eb32cedeb4ecb3454d246586521b6c6914dc8ed5c4725804c3273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3f626e310ef22794273975c0079bbcdd558908d8cc7267805798256fdf4f39ce34fefef806a456509b5b9be626db6922178c89784069ae3bf38836a78432c3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad2bb43114c25d1f2c28c09990da38edff6e49936442614472f2a8fc7d1fa26701e6c160054e8b58fe0acaf2ab2254090e07fac3458ecc14bbac9151bc25d95f"} 02:50:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:50:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:50:20 INFO - Contents: 02:50:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d9d8ed4bfce07a9b54a26384325fd39518910bd87168d8bdfd6607c5d3c2be1bca7aef51b74eb32cedeb4ecb3454d246586521b6c6914dc8ed5c4725804c3273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3f626e310ef22794273975c0079bbcdd558908d8cc7267805798256fdf4f39ce34fefef806a456509b5b9be626db6922178c89784069ae3bf38836a78432c3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad2bb43114c25d1f2c28c09990da38edff6e49936442614472f2a8fc7d1fa26701e6c160054e8b58fe0acaf2ab2254090e07fac3458ecc14bbac9151bc25d95f"} 02:50:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:50:20 INFO - Copying logs to upload dir... 02:50:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:50:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.353357 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-28 02:50:20.163402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:50:20.167896) ========= 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=1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d9d8ed4bfce07a9b54a26384325fd39518910bd87168d8bdfd6607c5d3c2be1bca7aef51b74eb32cedeb4ecb3454d246586521b6c6914dc8ed5c4725804c3273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3f626e310ef22794273975c0079bbcdd558908d8cc7267805798256fdf4f39ce34fefef806a456509b5b9be626db6922178c89784069ae3bf38836a78432c3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad2bb43114c25d1f2c28c09990da38edff6e49936442614472f2a8fc7d1fa26701e6c160054e8b58fe0acaf2ab2254090e07fac3458ecc14bbac9151bc25d95f"} 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.011207 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d9d8ed4bfce07a9b54a26384325fd39518910bd87168d8bdfd6607c5d3c2be1bca7aef51b74eb32cedeb4ecb3454d246586521b6c6914dc8ed5c4725804c3273", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3f626e310ef22794273975c0079bbcdd558908d8cc7267805798256fdf4f39ce34fefef806a456509b5b9be626db6922178c89784069ae3bf38836a78432c3f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad2bb43114c25d1f2c28c09990da38edff6e49936442614472f2a8fc7d1fa26701e6c160054e8b58fe0acaf2ab2254090e07fac3458ecc14bbac9151bc25d95f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:50:20.195102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:50:20.195552) ========= 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=1f5564757af27664ca02d71f000001b0-1467106182.729402-281888992 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:50:20.279558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:50:20.279940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:50:20.280324) ========= ========= Total master_lag: 0.19 =========