builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1466648552.71 results: success (0) buildid: 20160622163003 builduid: 6907781e6871434c91d1b3144a705520 revision: d2a087cdfb007a8a1aa919fcea061af9970fed72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.708673) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.709157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.709824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.775364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.775857) ========= 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=af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 19:22:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-06-22 19:22:32 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082562 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.880124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.880469) ========= 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=af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021841 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.932194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.932538) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2a087cdfb007a8a1aa919fcea061af9970fed72 --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 d2a087cdfb007a8a1aa919fcea061af9970fed72 --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=af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 19:22:33,094 truncating revision to first 12 chars 2016-06-22 19:22:33,094 Setting DEBUG logging. 2016-06-22 19:22:33,094 attempt 1/10 2016-06-22 19:22:33,094 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2a087cdfb00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 19:22:33,538 unpacking tar archive at: mozilla-inbound-d2a087cdfb00/testing/mozharness/ program finished with exit code 0 elapsedTime=0.788581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:33.736613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:33.736977) ========= script_repo_revision: d2a087cdfb007a8a1aa919fcea061af9970fed72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:33.737450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:33.737752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:33.747223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-22 19:22:33.747549) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:22:33 INFO - MultiFileLogger online at 20160622 19:22:33 in /builds/slave/test 19:22:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:22:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:22:33 INFO - {'append_to_log': False, 19:22:33 INFO - 'base_work_dir': '/builds/slave/test', 19:22:33 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:22:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:22:33 INFO - 'branch': 'Mozilla-Inbound', 19:22:33 INFO - 'buildbot_json_path': 'buildprops.json', 19:22:33 INFO - 'config_files': ('talos/linux_config.py',), 19:22:33 INFO - 'default_actions': ('clobber', 19:22:33 INFO - 'read-buildbot-config', 19:22:33 INFO - 'download-and-extract', 19:22:33 INFO - 'populate-webroot', 19:22:33 INFO - 'create-virtualenv', 19:22:33 INFO - 'install', 19:22:33 INFO - 'run-tests'), 19:22:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:22:33 INFO - 'download_minidump_stackwalk': True, 19:22:33 INFO - 'download_symbols': 'ondemand', 19:22:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:22:33 INFO - 'tooltool.py': '/tools/tooltool.py', 19:22:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:22:33 INFO - '/tools/misc-python/virtualenv.py')}, 19:22:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:22:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:22:33 INFO - 'installer_path': 'installer.exe', 19:22:33 INFO - 'log_level': 'info', 19:22:33 INFO - 'log_name': 'talos', 19:22:33 INFO - 'log_to_console': True, 19:22:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:22:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:22:33 INFO - 'opt_config_files': (), 19:22:33 INFO - 'pip_index': False, 19:22:33 INFO - 'sps_profile': False, 19:22:33 INFO - 'sps_profile_interval': 0, 19:22:33 INFO - 'suite': 'dromaeojs', 19:22:33 INFO - 'system_bits': '32', 19:22:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:22:33 INFO - 'title': 'talos-linux64-ix-020', 19:22:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:22:33 INFO - 'use_talos_json': True, 19:22:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:22:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:22:33 INFO - 'work_dir': 'build'} 19:22:33 INFO - ##### 19:22:33 INFO - ##### Running clobber step. 19:22:33 INFO - ##### 19:22:33 INFO - Running pre-action listener: _resource_record_pre_action 19:22:33 INFO - Running main action method: clobber 19:22:33 INFO - rmtree: /builds/slave/test/build 19:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:22:34 INFO - Running post-action listener: _resource_record_post_action 19:22:34 INFO - ##### 19:22:34 INFO - ##### Finished clobber step (success) 19:22:34 INFO - ##### 19:22:34 INFO - ##### 19:22:34 INFO - ##### Running read-buildbot-config step. 19:22:34 INFO - ##### 19:22:34 INFO - Running pre-action listener: _resource_record_pre_action 19:22:34 INFO - Running main action method: read_buildbot_config 19:22:34 INFO - Using buildbot properties: 19:22:34 INFO - { 19:22:34 INFO - "project": "", 19:22:34 INFO - "product": "firefox", 19:22:34 INFO - "script_repo_revision": "production", 19:22:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:22:34 INFO - "repository": "", 19:22:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:22:34 INFO - "buildid": "20160622163003", 19:22:34 INFO - "pgo_build": "True", 19:22:34 INFO - "basedir": "/builds/slave/test", 19:22:34 INFO - "buildnumber": 1973, 19:22:34 INFO - "slavename": "talos-linux64-ix-020", 19:22:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:22:34 INFO - "platform": "ubuntu64_hw", 19:22:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:22:34 INFO - "branch": "mozilla-inbound", 19:22:34 INFO - "repo_path": "integration/mozilla-inbound", 19:22:34 INFO - "revision": "d2a087cdfb007a8a1aa919fcea061af9970fed72", 19:22:34 INFO - "stage_platform": "linux64-pgo", 19:22:34 INFO - "builduid": "6907781e6871434c91d1b3144a705520", 19:22:34 INFO - "slavebuilddir": "test" 19:22:34 INFO - } 19:22:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:22:34 INFO - Running post-action listener: _resource_record_post_action 19:22:34 INFO - ##### 19:22:34 INFO - ##### Finished read-buildbot-config step (success) 19:22:34 INFO - ##### 19:22:34 INFO - ##### 19:22:34 INFO - ##### Running download-and-extract step. 19:22:34 INFO - ##### 19:22:34 INFO - Running pre-action listener: _resource_record_pre_action 19:22:34 INFO - Running main action method: download_and_extract 19:22:34 INFO - mkdir: /builds/slave/test/build/tests 19:22:34 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')]} 19:22:34 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:22:37 INFO - Downloaded 1361 bytes. 19:22:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:22:37 INFO - Using the following test package requirements: 19:22:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:22:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:22:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'jsshell-linux-x86_64.zip'], 19:22:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:22:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:22:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:22:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:22:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:22:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:22:37 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')]} 19:22:37 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:22:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:22:53 INFO - Downloaded 24269771 bytes. 19:22:53 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'] 19:22:53 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 19:22:54 INFO - Return code: 0 19:22:54 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 19:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:54 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:22:57 INFO - Downloaded 24269771 bytes. 19:22:57 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'] 19:22:57 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 19:22:59 INFO - Return code: 0 19:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:59 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:22:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:22:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:22:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:23:00 INFO - Downloaded 14405384 bytes. 19:23:00 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'] 19:23:00 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 19:23:00 INFO - Return code: 0 19:23:00 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')]} 19:23:00 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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 19:23:02 INFO - Downloaded 60125999 bytes. 19:23:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:02 INFO - mkdir: /builds/slave/test/properties 19:23:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:23:02 INFO - Writing to file /builds/slave/test/properties/build_url 19:23:02 INFO - Contents: 19:23:02 INFO - build_url:https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:03 INFO - Running post-action listener: _resource_record_post_action 19:23:03 INFO - Running post-action listener: set_extra_try_arguments 19:23:03 INFO - ##### 19:23:03 INFO - ##### Finished download-and-extract step (success) 19:23:03 INFO - ##### 19:23:03 INFO - ##### 19:23:03 INFO - ##### Running populate-webroot step. 19:23:03 INFO - ##### 19:23:03 INFO - Running pre-action listener: _resource_record_pre_action 19:23:03 INFO - Running main action method: populate_webroot 19:23:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:23:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:23:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:23:03 INFO - '--tppagecycles', 19:23:03 INFO - '7'], 19:23:03 INFO - 'tests': ['tsvgm']}}, 19:23:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:23:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:23:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:23:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:23:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['damp', 'tps']}, 19:23:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'tests': ['damp', 'tps']}, 19:23:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['dromaeo_dom']}, 19:23:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:23:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['basic_compositor_video']}, 19:23:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:23:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['a11yr', 19:23:03 INFO - 'ts_paint', 19:23:03 INFO - 'tpaint', 19:23:03 INFO - 'sessionrestore', 19:23:03 INFO - 'sessionrestore_no_auto_restore', 19:23:03 INFO - 'tabpaint']}, 19:23:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:23:03 INFO - 'ts_paint', 19:23:03 INFO - 'tpaint', 19:23:03 INFO - 'sessionrestore', 19:23:03 INFO - 'sessionrestore_no_auto_restore', 19:23:03 INFO - 'tabpaint']}, 19:23:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:23:03 INFO - 'ts_paint', 19:23:03 INFO - 'tpaint', 19:23:03 INFO - 'sessionrestore', 19:23:03 INFO - 'sessionrestore_no_auto_restore', 19:23:03 INFO - 'tabpaint']}, 19:23:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:23:03 INFO - 'ts_paint', 19:23:03 INFO - 'tpaint', 19:23:03 INFO - 'sessionrestore', 19:23:03 INFO - 'sessionrestore_no_auto_restore', 19:23:03 INFO - 'tabpaint']}, 19:23:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['a11yr', 19:23:03 INFO - 'ts_paint', 19:23:03 INFO - 'tpaint', 19:23:03 INFO - 'sessionrestore', 19:23:03 INFO - 'sessionrestore_no_auto_restore', 19:23:03 INFO - 'tabpaint']}, 19:23:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['a11yr', 19:23:03 INFO - 'ts_paint', 19:23:03 INFO - 'tpaint', 19:23:03 INFO - 'sessionrestore', 19:23:03 INFO - 'sessionrestore_no_auto_restore', 19:23:03 INFO - 'tabpaint']}, 19:23:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['tsvgx', 19:23:03 INFO - 'tsvgr_opacity', 19:23:03 INFO - 'tart', 19:23:03 INFO - 'tscrollx', 19:23:03 INFO - 'cart']}, 19:23:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:23:03 INFO - 'tsvgr_opacity', 19:23:03 INFO - 'tart', 19:23:03 INFO - 'tscrollx', 19:23:03 INFO - 'cart']}, 19:23:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'talos_options': ['--disable-e10s'], 19:23:03 INFO - 'tests': ['tp5o']}, 19:23:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'tests': ['tp5o']}, 19:23:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'talos_options': ['--disable-e10s', 19:23:03 INFO - '--xperf_path', 19:23:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:03 INFO - 'tests': ['tp5n']}, 19:23:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:03 INFO - 'talos_options': ['--xperf_path', 19:23:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:03 INFO - 'tests': ['tp5n']}}, 19:23:03 INFO - 'talos.zip': {'path': '', 19:23:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:23:03 INFO - Running post-action listener: _resource_record_post_action 19:23:03 INFO - ##### 19:23:03 INFO - ##### Finished populate-webroot step (success) 19:23:03 INFO - ##### 19:23:03 INFO - ##### 19:23:03 INFO - ##### Running create-virtualenv step. 19:23:03 INFO - ##### 19:23:03 INFO - Running pre-action listener: _resource_record_pre_action 19:23:03 INFO - Running main action method: create_virtualenv 19:23:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:23:03 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 19:23:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:23:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:23:03 INFO - Using real prefix '/usr' 19:23:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:23:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:23:06 INFO - Installing pip.................done. 19:23:06 INFO - Return code: 0 19:23:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:23:06 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')]} 19:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:06 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')]} 19:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:06 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:06 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 19:23:06 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 19:23:06 INFO - Using env: {'DISPLAY': ':0', 19:23:06 INFO - 'HOME': '/home/cltbld', 19:23:06 INFO - 'LANG': 'en_US.UTF-8', 19:23:06 INFO - 'LANGUAGE': 'en_US:en', 19:23:06 INFO - 'LOGNAME': 'cltbld', 19:23:06 INFO - 'MAIL': '/var/mail/cltbld', 19:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:06 INFO - 'MOZ_NO_REMOTE': '1', 19:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:06 INFO - 'NO_EM_RESTART': '1', 19:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:06 INFO - 'PWD': '/builds/slave/test', 19:23:06 INFO - 'SHELL': '/bin/bash', 19:23:06 INFO - 'SHLVL': '1', 19:23:06 INFO - 'TERM': 'linux', 19:23:06 INFO - 'TMOUT': '86400', 19:23:06 INFO - 'USER': 'cltbld', 19:23:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:06 INFO - '_': '/tools/buildbot/bin/python'} 19:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:06 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 19:23:06 INFO - Cleaning up... 19:23:06 INFO - Return code: 0 19:23:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:23:06 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')]} 19:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:06 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')]} 19:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:06 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:06 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 19:23:06 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 19:23:06 INFO - Using env: {'DISPLAY': ':0', 19:23:06 INFO - 'HOME': '/home/cltbld', 19:23:06 INFO - 'LANG': 'en_US.UTF-8', 19:23:06 INFO - 'LANGUAGE': 'en_US:en', 19:23:06 INFO - 'LOGNAME': 'cltbld', 19:23:06 INFO - 'MAIL': '/var/mail/cltbld', 19:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:06 INFO - 'MOZ_NO_REMOTE': '1', 19:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:06 INFO - 'NO_EM_RESTART': '1', 19:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:06 INFO - 'PWD': '/builds/slave/test', 19:23:06 INFO - 'SHELL': '/bin/bash', 19:23:06 INFO - 'SHLVL': '1', 19:23:06 INFO - 'TERM': 'linux', 19:23:06 INFO - 'TMOUT': '86400', 19:23:06 INFO - 'USER': 'cltbld', 19:23:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:06 INFO - '_': '/tools/buildbot/bin/python'} 19:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:06 INFO - Downloading/unpacking psutil>=3.1.1 19:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:08 INFO - Installing collected packages: psutil 19:23:08 INFO - Running setup.py install for psutil 19:23:08 INFO - building 'psutil._psutil_linux' extension 19:23:08 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 19:23:08 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 19:23:08 INFO - building 'psutil._psutil_posix' extension 19:23:08 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 19:23:08 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 19:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:09 INFO - Successfully installed psutil 19:23:09 INFO - Cleaning up... 19:23:09 INFO - Return code: 0 19:23:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:23: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 mozsystemmonitor==0.3 19:23:09 INFO - Using env: {'DISPLAY': ':0', 19:23:09 INFO - 'HOME': '/home/cltbld', 19:23:09 INFO - 'LANG': 'en_US.UTF-8', 19:23:09 INFO - 'LANGUAGE': 'en_US:en', 19:23:09 INFO - 'LOGNAME': 'cltbld', 19:23:09 INFO - 'MAIL': '/var/mail/cltbld', 19:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:09 INFO - 'MOZ_NO_REMOTE': '1', 19:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:09 INFO - 'NO_EM_RESTART': '1', 19:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:09 INFO - 'PWD': '/builds/slave/test', 19:23:09 INFO - 'SHELL': '/bin/bash', 19:23:09 INFO - 'SHLVL': '1', 19:23:09 INFO - 'TERM': 'linux', 19:23:09 INFO - 'TMOUT': '86400', 19:23:09 INFO - 'USER': 'cltbld', 19:23:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:09 INFO - '_': '/tools/buildbot/bin/python'} 19:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:23:11 INFO - Installing collected packages: mozsystemmonitor 19:23:11 INFO - Running setup.py install for mozsystemmonitor 19:23:11 INFO - Successfully installed mozsystemmonitor 19:23:11 INFO - Cleaning up... 19:23:11 INFO - Return code: 0 19:23:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:11 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:11 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 19:23:11 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 19:23:11 INFO - Using env: {'DISPLAY': ':0', 19:23:11 INFO - 'HOME': '/home/cltbld', 19:23:11 INFO - 'LANG': 'en_US.UTF-8', 19:23:11 INFO - 'LANGUAGE': 'en_US:en', 19:23:11 INFO - 'LOGNAME': 'cltbld', 19:23:11 INFO - 'MAIL': '/var/mail/cltbld', 19:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:11 INFO - 'MOZ_NO_REMOTE': '1', 19:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:11 INFO - 'NO_EM_RESTART': '1', 19:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:11 INFO - 'PWD': '/builds/slave/test', 19:23:11 INFO - 'SHELL': '/bin/bash', 19:23:11 INFO - 'SHLVL': '1', 19:23:11 INFO - 'TERM': 'linux', 19:23:11 INFO - 'TMOUT': '86400', 19:23:11 INFO - 'USER': 'cltbld', 19:23:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:11 INFO - '_': '/tools/buildbot/bin/python'} 19:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:11 INFO - Downloading/unpacking jsonschema==2.5.1 19:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:23:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:13 INFO - Downloading functools32-3.2.3-2.tar.gz 19:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:23:13 INFO - warning: no files found matching '*.txt' 19:23:13 INFO - no previously-included directories found matching 'build' 19:23:13 INFO - no previously-included directories found matching 'dist' 19:23:13 INFO - no previously-included directories found matching '.git*' 19:23:13 INFO - Installing collected packages: jsonschema, functools32 19:23:13 INFO - Running setup.py install for functools32 19:23:13 INFO - warning: no files found matching '*.txt' 19:23:13 INFO - no previously-included directories found matching 'build' 19:23:13 INFO - no previously-included directories found matching 'dist' 19:23:13 INFO - no previously-included directories found matching '.git*' 19:23:13 INFO - Successfully installed jsonschema functools32 19:23:13 INFO - Cleaning up... 19:23:13 INFO - Return code: 0 19:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:23:13 INFO - Using env: {'DISPLAY': ':0', 19:23:13 INFO - 'HOME': '/home/cltbld', 19:23:13 INFO - 'LANG': 'en_US.UTF-8', 19:23:13 INFO - 'LANGUAGE': 'en_US:en', 19:23:13 INFO - 'LOGNAME': 'cltbld', 19:23:13 INFO - 'MAIL': '/var/mail/cltbld', 19:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:13 INFO - 'MOZ_NO_REMOTE': '1', 19:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:13 INFO - 'NO_EM_RESTART': '1', 19:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:13 INFO - 'PWD': '/builds/slave/test', 19:23:13 INFO - 'SHELL': '/bin/bash', 19:23:13 INFO - 'SHLVL': '1', 19:23:13 INFO - 'TERM': 'linux', 19:23:13 INFO - 'TMOUT': '86400', 19:23:13 INFO - 'USER': 'cltbld', 19:23:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:13 INFO - '_': '/tools/buildbot/bin/python'} 19:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:14 INFO - Downloading/unpacking blobuploader==1.2.4 19:23:14 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 19:23:14 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 19:23:14 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 19:23:14 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 19:23:14 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 19:23:14 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 19:23:15 INFO - Downloading blobuploader-1.2.4.tar.gz 19:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:23:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:23:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:23:16 INFO - Downloading docopt-0.6.1.tar.gz 19:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:23:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:23:16 INFO - Running setup.py install for blobuploader 19:23:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:23:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:23:16 INFO - Running setup.py install for requests 19:23:17 INFO - Running setup.py install for docopt 19:23:17 INFO - Successfully installed blobuploader requests docopt 19:23:17 INFO - Cleaning up... 19:23:17 INFO - Return code: 0 19:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:17 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')]} 19:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:17 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')]} 19:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:17 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:17 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 19:23:17 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 19:23:17 INFO - Using env: {'DISPLAY': ':0', 19:23:17 INFO - 'HOME': '/home/cltbld', 19:23:17 INFO - 'LANG': 'en_US.UTF-8', 19:23:17 INFO - 'LANGUAGE': 'en_US:en', 19:23:17 INFO - 'LOGNAME': 'cltbld', 19:23:17 INFO - 'MAIL': '/var/mail/cltbld', 19:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:17 INFO - 'MOZ_NO_REMOTE': '1', 19:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:17 INFO - 'NO_EM_RESTART': '1', 19:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:17 INFO - 'PWD': '/builds/slave/test', 19:23:17 INFO - 'SHELL': '/bin/bash', 19:23:17 INFO - 'SHLVL': '1', 19:23:17 INFO - 'TERM': 'linux', 19:23:17 INFO - 'TMOUT': '86400', 19:23:17 INFO - 'USER': 'cltbld', 19:23:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:17 INFO - '_': '/tools/buildbot/bin/python'} 19:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:17 INFO - Running setup.py (path:/tmp/pip-KIJ3Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:17 INFO - Running setup.py (path:/tmp/pip-Wo2ief-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:17 INFO - Running setup.py (path:/tmp/pip-DJfF5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:17 INFO - Running setup.py (path:/tmp/pip-bX39j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:17 INFO - Running setup.py (path:/tmp/pip-l6HSFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:17 INFO - Running setup.py (path:/tmp/pip-CxGlZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:18 INFO - Running setup.py (path:/tmp/pip-03wWdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:18 INFO - Running setup.py (path:/tmp/pip-4vrqH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:18 INFO - Running setup.py (path:/tmp/pip-ONWItR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:18 INFO - Running setup.py (path:/tmp/pip-NGdDvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:18 INFO - Running setup.py (path:/tmp/pip-hpPZxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:18 INFO - Running setup.py (path:/tmp/pip-pCWJXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:18 INFO - Running setup.py (path:/tmp/pip-sK9LJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:18 INFO - Running setup.py (path:/tmp/pip-9LSK0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:18 INFO - Running setup.py (path:/tmp/pip-obw5jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:18 INFO - Running setup.py (path:/tmp/pip-2kqr_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:18 INFO - Running setup.py (path:/tmp/pip-MR8cjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:23:18 INFO - Running setup.py install for manifestparser 19:23:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:23:18 INFO - Running setup.py install for mozcrash 19:23:19 INFO - Running setup.py install for mozdebug 19:23:19 INFO - Running setup.py install for mozdevice 19:23:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Running setup.py install for mozfile 19:23:19 INFO - Running setup.py install for mozhttpd 19:23:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Running setup.py install for mozinfo 19:23:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Running setup.py install for mozInstall 19:23:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Running setup.py install for mozleak 19:23:19 INFO - Running setup.py install for mozlog 19:23:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Running setup.py install for moznetwork 19:23:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:23:19 INFO - Running setup.py install for mozprocess 19:23:20 INFO - Running setup.py install for mozprofile 19:23:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:23:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:23:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:23:20 INFO - Running setup.py install for mozrunner 19:23:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:23:20 INFO - Running setup.py install for mozscreenshot 19:23:20 INFO - Running setup.py install for moztest 19:23:20 INFO - Running setup.py install for mozversion 19:23:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:23:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:23:20 INFO - Cleaning up... 19:23:20 INFO - Return code: 0 19:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:20 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:20 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 19:23:20 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 19:23:20 INFO - Using env: {'DISPLAY': ':0', 19:23:20 INFO - 'HOME': '/home/cltbld', 19:23:20 INFO - 'LANG': 'en_US.UTF-8', 19:23:20 INFO - 'LANGUAGE': 'en_US:en', 19:23:20 INFO - 'LOGNAME': 'cltbld', 19:23:20 INFO - 'MAIL': '/var/mail/cltbld', 19:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:20 INFO - 'MOZ_NO_REMOTE': '1', 19:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:20 INFO - 'NO_EM_RESTART': '1', 19:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:20 INFO - 'PWD': '/builds/slave/test', 19:23:20 INFO - 'SHELL': '/bin/bash', 19:23:20 INFO - 'SHLVL': '1', 19:23:20 INFO - 'TERM': 'linux', 19:23:20 INFO - 'TMOUT': '86400', 19:23:20 INFO - 'USER': 'cltbld', 19:23:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:20 INFO - '_': '/tools/buildbot/bin/python'} 19:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:20 INFO - Running setup.py (path:/tmp/pip-fZDeyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:20 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)) 19:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:20 INFO - Running setup.py (path:/tmp/pip-BBJxr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:20 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)) 19:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:20 INFO - Running setup.py (path:/tmp/pip-qLkGbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:21 INFO - Running setup.py (path:/tmp/pip-TJT_rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:21 INFO - Running setup.py (path:/tmp/pip-55Lr8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:21 INFO - Running setup.py (path:/tmp/pip-_RgH3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:21 INFO - Running setup.py (path:/tmp/pip-2ZP3xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:21 INFO - Running setup.py (path:/tmp/pip-Qf_PaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:21 INFO - Running setup.py (path:/tmp/pip-8Y4Zwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:21 INFO - Running setup.py (path:/tmp/pip-RpKf4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:21 INFO - Running setup.py (path:/tmp/pip-wi1mVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:21 INFO - Running setup.py (path:/tmp/pip-CjchOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:21 INFO - Running setup.py (path:/tmp/pip-notwBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:21 INFO - Running setup.py (path:/tmp/pip-XiCBSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:21 INFO - Running setup.py (path:/tmp/pip-gilt8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:21 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)) 19:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:21 INFO - Running setup.py (path:/tmp/pip-Gk83yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:22 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)) 19:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:22 INFO - Running setup.py (path:/tmp/pip-2wdSYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:22 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)) 19:23:22 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)) 19:23:22 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)) 19:23:22 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)) 19:23:22 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)) 19:23:22 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)) 19:23:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23:23 INFO - Downloading blessings-1.6.tar.gz 19:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:23:24 INFO - Installing collected packages: blessings 19:23:24 INFO - Running setup.py install for blessings 19:23:24 INFO - Successfully installed blessings 19:23:24 INFO - Cleaning up... 19:23:24 INFO - Return code: 0 19:23:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:24 INFO - Reading from file tmpfile_stdout 19:23:24 INFO - Current package versions: 19:23:24 INFO - argparse == 1.2.1 19:23:24 INFO - blessings == 1.6 19:23:24 INFO - blobuploader == 1.2.4 19:23:24 INFO - docopt == 0.6.1 19:23:24 INFO - functools32 == 3.2.3-2 19:23:24 INFO - jsonschema == 2.5.1 19:23:24 INFO - manifestparser == 1.1 19:23:24 INFO - mozInstall == 1.12 19:23:24 INFO - mozcrash == 0.17 19:23:24 INFO - mozdebug == 0.1 19:23:24 INFO - mozdevice == 0.48 19:23:24 INFO - mozfile == 1.2 19:23:24 INFO - mozhttpd == 0.7 19:23:24 INFO - mozinfo == 0.9 19:23:24 INFO - mozleak == 0.1 19:23:24 INFO - mozlog == 3.2 19:23:24 INFO - moznetwork == 0.27 19:23:24 INFO - mozprocess == 0.22 19:23:24 INFO - mozprofile == 0.28 19:23:24 INFO - mozrunner == 6.11 19:23:24 INFO - mozscreenshot == 0.1 19:23:24 INFO - mozsystemmonitor == 0.3 19:23:24 INFO - moztest == 0.7 19:23:24 INFO - mozversion == 1.4 19:23:24 INFO - psutil == 3.1.1 19:23:24 INFO - requests == 1.2.3 19:23:24 INFO - wsgiref == 0.1.2 19:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:24 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:24 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 19:23:24 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 19:23:24 INFO - Using env: {'DISPLAY': ':0', 19:23:24 INFO - 'HOME': '/home/cltbld', 19:23:24 INFO - 'LANG': 'en_US.UTF-8', 19:23:24 INFO - 'LANGUAGE': 'en_US:en', 19:23:24 INFO - 'LOGNAME': 'cltbld', 19:23:24 INFO - 'MAIL': '/var/mail/cltbld', 19:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:24 INFO - 'MOZ_NO_REMOTE': '1', 19:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:24 INFO - 'NO_EM_RESTART': '1', 19:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:24 INFO - 'PWD': '/builds/slave/test', 19:23:24 INFO - 'SHELL': '/bin/bash', 19:23:24 INFO - 'SHLVL': '1', 19:23:24 INFO - 'TERM': 'linux', 19:23:24 INFO - 'TMOUT': '86400', 19:23:24 INFO - 'USER': 'cltbld', 19:23:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:24 INFO - '_': '/tools/buildbot/bin/python'} 19:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 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)) 19:23:24 INFO - Cleaning up... 19:23:24 INFO - Return code: 0 19:23:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:24 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:24 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 19:23:24 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 19:23:24 INFO - Using env: {'DISPLAY': ':0', 19:23:24 INFO - 'HOME': '/home/cltbld', 19:23:24 INFO - 'LANG': 'en_US.UTF-8', 19:23:24 INFO - 'LANGUAGE': 'en_US:en', 19:23:24 INFO - 'LOGNAME': 'cltbld', 19:23:24 INFO - 'MAIL': '/var/mail/cltbld', 19:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:24 INFO - 'MOZ_NO_REMOTE': '1', 19:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:24 INFO - 'NO_EM_RESTART': '1', 19:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:24 INFO - 'PWD': '/builds/slave/test', 19:23:24 INFO - 'SHELL': '/bin/bash', 19:23:24 INFO - 'SHLVL': '1', 19:23:24 INFO - 'TERM': 'linux', 19:23:24 INFO - 'TMOUT': '86400', 19:23:24 INFO - 'USER': 'cltbld', 19:23:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:24 INFO - '_': '/tools/buildbot/bin/python'} 19:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:23:24 INFO - Cleaning up... 19:23:24 INFO - Return code: 0 19:23:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:24 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 0x7f33f81b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', '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 19:23:24 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 19:23:24 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 19:23:24 INFO - Using env: {'DISPLAY': ':0', 19:23:24 INFO - 'HOME': '/home/cltbld', 19:23:24 INFO - 'LANG': 'en_US.UTF-8', 19:23:24 INFO - 'LANGUAGE': 'en_US:en', 19:23:24 INFO - 'LOGNAME': 'cltbld', 19:23:24 INFO - 'MAIL': '/var/mail/cltbld', 19:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:24 INFO - 'MOZ_NO_REMOTE': '1', 19:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:24 INFO - 'NO_EM_RESTART': '1', 19:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:24 INFO - 'PWD': '/builds/slave/test', 19:23:24 INFO - 'SHELL': '/bin/bash', 19:23:24 INFO - 'SHLVL': '1', 19:23:24 INFO - 'TERM': 'linux', 19:23:24 INFO - 'TMOUT': '86400', 19:23:24 INFO - 'USER': 'cltbld', 19:23:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:24 INFO - '_': '/tools/buildbot/bin/python'} 19:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:25 INFO - Downloading/unpacking flake8 19:23:25 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 19:23:25 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 19:23:25 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 19:23:25 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 19:23:25 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 19:23:25 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 19:23:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:23:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:23:26 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 19:23:26 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 19:23:26 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 19:23:26 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 19:23:26 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 19:23:26 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 19:23:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:23:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 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 19:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:27 INFO - no previously-included directories found matching 'docs/_build' 19:23:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:23:27 INFO - Running setup.py install for pep8 19:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:27 INFO - no previously-included directories found matching 'docs/_build' 19:23:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:23:27 INFO - Cleaning up... 19:23:28 INFO - Return code: 0 19:23:28 INFO - Running post-action listener: _resource_record_post_action 19:23:28 INFO - Running post-action listener: _start_resource_monitoring 19:23:28 INFO - Starting resource monitoring. 19:23:28 INFO - ##### 19:23:28 INFO - ##### Finished create-virtualenv step (success) 19:23:28 INFO - ##### 19:23:28 INFO - ##### 19:23:28 INFO - ##### Running install step. 19:23:28 INFO - ##### 19:23:28 INFO - Running pre-action listener: _resource_record_pre_action 19:23:28 INFO - Running main action method: install 19:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:28 INFO - Reading from file tmpfile_stdout 19:23:28 INFO - Detecting whether we're running mozinstall >=1.0... 19:23:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:23:28 INFO - Reading from file tmpfile_stdout 19:23:28 INFO - Output received: 19:23:28 INFO - Usage: mozinstall [options] installer 19:23:28 INFO - Options: 19:23:28 INFO - -h, --help show this help message and exit 19:23:28 INFO - -d DEST, --destination=DEST 19:23:28 INFO - Directory to install application into. [default: 19:23:28 INFO - "/builds/slave/test"] 19:23:28 INFO - --app=APP Application being installed. [default: firefox] 19:23:28 INFO - mkdir: /builds/slave/test/build/application 19:23:28 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'] 19:23:28 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 19:23:45 INFO - Reading from file tmpfile_stdout 19:23:45 INFO - Output received: 19:23:45 INFO - /builds/slave/test/build/application/firefox/firefox 19:23:45 INFO - Running post-action listener: _resource_record_post_action 19:23:45 INFO - ##### 19:23:45 INFO - ##### Finished install step (success) 19:23:45 INFO - ##### 19:23:45 INFO - ##### 19:23:45 INFO - ##### Running run-tests step. 19:23:45 INFO - ##### 19:23:45 INFO - Running pre-action listener: _resource_record_pre_action 19:23:45 INFO - Running main action method: run_tests 19:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:45 INFO - Python 2.7.3 19:23:45 INFO - Return code: 0 19:23:45 INFO - grabbing minidump binary from tooltool 19:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:45 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 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:45 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 19:23:45 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 19:23:45 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 19:23:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:23:45 INFO - Return code: 0 19:23:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:23:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:23:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:23:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:23:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:23:46 INFO - Return code: 0 19:23:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:23:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:23:46 INFO - Using env: {'DISPLAY': ':0', 19:23:46 INFO - 'HOME': '/home/cltbld', 19:23:46 INFO - 'LANG': 'en_US.UTF-8', 19:23:46 INFO - 'LANGUAGE': 'en_US:en', 19:23:46 INFO - 'LOGNAME': 'cltbld', 19:23:46 INFO - 'MAIL': '/var/mail/cltbld', 19:23:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:23:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:46 INFO - 'MOZ_NO_REMOTE': '1', 19:23:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:46 INFO - 'NO_EM_RESTART': '1', 19:23:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:46 INFO - 'PWD': '/builds/slave/test', 19:23:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:23:46 INFO - 'SHELL': '/bin/bash', 19:23:46 INFO - 'SHLVL': '1', 19:23:46 INFO - 'TERM': 'linux', 19:23:46 INFO - 'TMOUT': '86400', 19:23:46 INFO - 'USER': 'cltbld', 19:23:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440', 19:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:46 INFO - '_': '/tools/buildbot/bin/python'} 19:23:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:23:46 INFO - mozversion application_buildid: 20160622163003 19:23:46 INFO - mozversion application_changeset: d2a087cdfb007a8a1aa919fcea061af9970fed72 19:23:46 INFO - mozversion application_display_name: Nightly 19:23:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:23:46 INFO - mozversion application_name: Firefox 19:23:46 INFO - mozversion application_remotingname: firefox 19:23:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:23:46 INFO - mozversion application_vendor: Mozilla 19:23:46 INFO - mozversion application_version: 50.0a1 19:23:46 INFO - mozversion platform_buildid: 20160622163003 19:23:46 INFO - mozversion platform_changeset: d2a087cdfb007a8a1aa919fcea061af9970fed72 19:23:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:23:46 INFO - mozversion platform_version: 50.0a1 19:23:46 INFO - using testdate: 1466648626 19:23:46 INFO - actual date: 1466648626 19:23:46 INFO - starting webserver on 'localhost:48581' 19:23:46 INFO - SUITE-START | Running 2 tests 19:23:46 INFO - TEST-START | dromaeo_css 19:23:46 INFO - operating with platform_type : linux_ 19:23:46 INFO - Initialising browser for dromaeo_css test... 19:23:46 INFO - TEST-INFO | started process 12865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXHsulg/profile http://localhost:48581/getInfo.html) 19:23:51 INFO - PROCESS | 12865 | __metrics Screen width/height:1600/1200 19:23:51 INFO - PROCESS | 12865 | colorDepth:24 19:23:51 INFO - PROCESS | 12865 | Browser inner width/height: 1024/697 19:23:51 INFO - PROCESS | 12865 | __metrics 19:23:52 INFO - PROCESS | 12865 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:23:53 INFO - TEST-INFO | 12865: exit 0 19:23:53 INFO - Browser initialized. 19:23:53 INFO - Running cycle 1/1 for dromaeo_css test... 19:23:53 INFO - TEST-INFO | started process 12949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXHsulg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:05 INFO - PROCESS | 12949 | RSS: Main: 174338048 19:24:05 INFO - PROCESS | 12949 | 19:24:57 INFO - PROCESS | 12949 | 1466648697557 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] 19:27:05 INFO - PROCESS | 12949 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48581/tests/dromaeo/cssquery-ext.html) 19:27:06 INFO - PROCESS | 12949 | RSS: Main: 261607424 19:27:06 INFO - PROCESS | 12949 | 19:30:08 INFO - PROCESS | 12949 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-ext.html (next: http://localhost:48581/tests/dromaeo/cssquery-jquery.html) 19:30:09 INFO - PROCESS | 12949 | RSS: Main: 265760768 19:30:09 INFO - PROCESS | 12949 | 19:33:11 INFO - PROCESS | 12949 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48581/tests/dromaeo/cssquery-mootools.html) 19:33:12 INFO - PROCESS | 12949 | RSS: Main: 265494528 19:33:12 INFO - PROCESS | 12949 | 19:36:14 INFO - PROCESS | 12949 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48581/tests/dromaeo/cssquery-prototype.html) 19:36:14 INFO - PROCESS | 12949 | RSS: Main: 258670592 19:36:14 INFO - PROCESS | 12949 | 19:39:17 INFO - PROCESS | 12949 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48581/tests/dromaeo/cssquery-yui.html) 19:39:18 INFO - PROCESS | 12949 | RSS: Main: 222412800 19:39:18 INFO - PROCESS | 12949 | 19:42:20 INFO - PROCESS | 12949 | Cycle 1(1): loaded http://localhost:48581/tests/dromaeo/cssquery-yui.html (next: http://localhost:48581/tests/dromaeo/cssquery-dojo.html) 19:42:21 INFO - PROCESS | 12949 | RSS: Main: 290365440 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | __start_tp_report 19:42:21 INFO - PROCESS | 12949 | _x_x_mozilla_page_load 19:42:21 INFO - PROCESS | 12949 | _x_x_mozilla_page_load_details 19:42:21 INFO - PROCESS | 12949 | |i|pagename|runs| 19:42:21 INFO - PROCESS | 12949 | |0;dojo.html;3064.2952121012167;3080.9229769255767;3081.245094951737;3098.597182366295;3130.4521708700972;5290.709011004393;5326.520613144816;5395.514403703666;5421.647592906464;5449.809256676017;5305.734713264341;5332.14685650296;5443.156310771837;5467.316585426822;5469.890602187954;4786.521347865212;4866.270059491069;4879.6828206166665;4896.216605343146;5121.923171152435;4997.250412438145;5012.624053196025;5049.8485045448515;5072.137736584789;5081.237814327844;4772.3795906532105;4799.616030717569;4815.518448155191;4851.10254602896;4875.829345972874;4879.268109783561;4901.313816065754;4906.018796240731;4945.727984960826;4997.725125118117;4908.7300198489065;4934.40787105546;4950.87622809429;4951.801927922878;4998.075356059141;5229.11105112128;5291.497307755757;5321.042212401766;5323.96182744365;5366.91949620756;5755.798547050833;5793.507551858097;5819;5841.591088623798;5877.441643043904;5677.489025987681;5839.883202335929;5860.853478663025;5927.199828023205;5931.228940237785;5296.894062118736;5351.143816989302;5362.865928351784;5445.101558242845;5451.8364449066985;5930.436608522184;5938.703064846741;5942.108683697394;5943.257092863392;5945.524358051345;5435.8856434430845;5674.375818659944;5691.77232910679;5692.715364231854;5716.42835716425;5546.27898373217;5611.859703507445;5614.410486898899;5615.522680572197;5634.52106570946;5584.134459158837;5608.439156084359;5633.352164501053;5640.435956404409;5643.125315576092;5547.33431988164;5578.107502799614;5631.183478395692;5632.408597097327;5642.407547207484;4319.848805291863;4350.60844523988;4354.6951713380395;4383.430154080013;4392.846250381285;3852.903677408031;3874.1670540833857;3879.301725689403;3886.6696330811633;3909.159530700913;5243.764030618631;5252.159654455345;5309.070912590281;5350.545203657655;5356.8660783479945;5765.1640512125505;5806.65160090396;5835.124731290341;5866.67733274674;5891;5423.701696406735;5436;5438.564914806885;5443.510084092451;5445.264889239902;4902.044101400193;5013.1227035268685;5042.39491261051;5047.823326183566;5094.847154585368;6007.429294217042;6087.056506241451;6091.055886337536;6095.8476038098515;6142.78500252489;5915.260592425947;5932.644041357532;5934.169216309634;5935.347111817783;5938.465538101592;5747.023006088892;5918.822435326947;5985.910211346746;6071.787487437919;6088.665123418077;5695.316562012585;5717.113847353667;5717.285339332583;5722.914156287576;5783.508401785895;5866.3547009828035;5866.354700982974;5871.500922421642;5872.324682661549;5881.17663527098;5489.862753431196;5652.378238393691;5676.545876329967;5713.571482138773;5731.598788084794;5738.1679656450415;5746.569007324551;5748.252727145445;5748.770049197985;5750.13747937796;5606.551475881838;5624.437556244343;5624.690642014729;5624.859378515406;5625.212470254086;5561.499465048003;5604.411536788579;5674.517665998271;5678.716064196857;5785.334686510937;5516.475934786189;5590.5527557796095;5592.944070559242;5615.2700148980375;5621.662700237999 19:42:21 INFO - PROCESS | 12949 | |1;ext.html;593.5014587746292;608.777796104422;614.8708771158057;616.7594638091144;641.8523739539905;30359.848200758992;31049.534256986164;41143.38284925725;42386.57613423865;42465.78767106168;41312.38031429531;45863.770681146634;45988.3101753474;46058.76970615142;46064.309035364415;8903.376763626533;9065.546722663874;9066.77333066672;9082.09179082093;9091.909080909205;8839.07189745074;8954;8956.507392093432;8958.23854972328;8961.865572016392;9014.504202268872;9034.68378606749;9043.412178208428;9046.683366082156;9048.592813323383;8984.281257499384;9027.277817774628;9028.954855225682;9029.909700902972;9038.774030649254;8909.331800114953;8923.910760892373;8976.730698079067;8983.865242021375;8985.775355616162;41821.37267940983;42767.57232427667;42788.9350511704;42791.57208427907;42834.57165428368;3666.633336666312;3956.5845586213322;3980.044789250588;3984.183242435294;4078.082431452929;32047.839760801045;32535.186620334443;32739;32954.835225823954;34020.48969265463;4418.911621767579;4504.459464864237;4518.728876267402;4519.706219095749;4619.976900115478;348565;352616;353505;353712;354420;57575.424245757844;57664.71167644135;57905;57988.71005645029;58025.41974580284;60950.695246523486;61018.38981610216;61039.675238971606;61072.38927610756;61222.38777612256;14173.645658858404;14331.211783352015;14340.641483962776;14362.497312594009;14367.712645747026;11768.94115529417;11880.702982425508;11892.286462812259;11893.40532973348;11895.345755983504;15208.695826083416;16019.279132439067;16354.34582616682;16401.83598164027;16413.91793041051;5217.869553261199;6049.667268300285;6078.936186167403;6143.938560614337;6267.2792628848265;1047.8323468245044;1062.5263523400818;1073.9797192666997;1100.9779804404027;1103.3435106111851;32199.195020124214;32209.355812883612;32380.190495237806;32579.51130733041;32656.510152347735;1065.5311662868314;1075.1613741281813;1093.3002878157986;1169.5964892112208;1192.4037981009494;17155.656886862194;17164.742528862076;17238.827611723973;17361;17383.0855175775;555312;559749;562254;563953;565067;59735;59901.10148347778;59998;60113;60237.39762602405;1233.105998151351;1320.630223537411;1347.1109068015062;1357.7963305504056;1386.0921096681689;23621.763782361955;23790;23799.167029153898;24122.75877241205;24155.03379864856;49978.50021499739;50095.499045009085;50194.49805501898;50383.74808125936;50665.74667126641;403940;408194;408848;409021;409663;34067.65932340645;39303.41044884272;41014;41395.379069314586;41638;48675;48949.26576101433;49524.50475495199;50070.24894626511;50254.246186307966;41169.58830411657;41471.37792933048;41818.58181418269;42511.57488425076;43162.78418607887;41160;41855.790721047415;42222;42375.3643695351;42773.35839962465;40569.391459127546;40851.182976340904;41670;41680;41735.37396939109;34156;36858.44712329264;37287.6271237295;37630.435543467414;37699.81150094232;27141.321466963484;27508.862455687595;27763;29587.85206073956;29822.10533683993 19:42:21 INFO - PROCESS | 12949 | |2;jquery.html;388.5337594886137;390.2526661443338;395.51746868820067;397.5289282200592;415.8710799652108;14093.436262549485;16897.408590699328;18908.810911890876;19570.412887613376;19577.412677619657;14774.482893098744;15041.924790376033;17522.211500482477;18887.811121888775;18956.052197390145;4773.236282194849;5127.179651255799;5133.255677926699;5169.819056333029;5175.094358487268;5040.97479512602;5104.77028533715;5309.203619457074;5609.80365687201;5653.265075540174;5717.285339332583;5731.598788084836;5734.942650573504;5755.510781583549;5755.510781583571;5133.435322114565;5264.078786212397;5268.789248430058;5297.947020529784;5728.742206600713;5072.72100034498;5103.030424219386;5110.361204849394;5114.232865070269;5127.102757017507;13490.190588564717;14350.282485875665;14353.85646143546;14354.066985645899;14355.712885742227;2403.579373609629;2442.963355549668;2651.456451427472;2712.34903623131;2741.739534744196;10163.745906352326;10329.380237185793;10335.121514671262;10521.579136834518;10748.140148788078;1825.5071130794745;1963.2834015584351;1967.2622766462578;1975.1704284200528;1991.153759652142;80028.59985700093;84617.15382846216;85117.57441212816;85291;86094.99999999937;10568.947155264175;10713.83929241062;10757.677269681923;10970.244760838228;11168.776624467466;15407.845921540642;15556.455524056604;15560.299786509635;15574.688506229812;15580.143092130042;6694.966525167343;7158.2841715828;7524.774256772305;7625.923740762521;7887.329576985906;7464.962675186589;7505.4746167767735;7595.278448547379;7608.2391760823475;7730.149683534807;4451.198784218872;4531.56950089741;4672.369230153886;4799.400074990626;4899.779509922062;1882.444678819724;1924;1969.4363423329153;1969.5666953270259;1978.455924620712;909.377076702461;976.8241716490958;998.6255154317131;1059.586761163147;1060.3002018667642;19430.848658613533;19465.513362165777;19544.218231270876;19592;19892.403227903185;968.5496244246459;990.8365119755159;992.7220378294089;995.3778888194878;1036.522954789422;10328.173746100294;10825.458727063615;10869.34783912952;10918.836217456745;10949.33197378887;479044;481262;490623;495197;495986;82673.58663206766;83169;83804;98737;100382.4980875091;1000.229823036258;1031.4739482863793;1037.5071840875676;1039.0648416425279;1048.1771809129796;17165.57086072858;17376.91311543434;18240;18272.908635456737;18432.354867579572;43254.351184731626;44292;44310.33534496921;44541.55458445374;44926.55073449355;61300.38699612947;61704;62574.37425625685;62633;63324.36675633369;8818.603162857558;8980.730578082668;9029.419851526089;9029.819403612022;9033.457992520469;10156.89843101589;12643.810342844681;13774;13817.51638692681;14012.579622611338;11850.229735067192;11955.282683039046;11996.820047699117;12120.575779847662;12500.562480313145;11960.58137965167;11967.940160299491;12123;12139.939300303442;12290.262584244616;10551.683449496528;12305.56930507428;12472.688182795502;12596.937015314865;12630.368481576068;8797.604107815292;8871.112888711077;9123.361364704408;9233.861492077758;9259.305552083486;8972.461652300883;11959.880401196224;12141.150119491904;12294.077944154045;12423.130380873252 19:42:21 INFO - PROCESS | 12949 | |3;mootools.html;1341.912775669582;1485.279639374903;1520.5742392130203;1624.7969003874516;1795.8742887997846;8414.116517765638;8838;8845.601947912342;9135.086491350861;9145.862812057809;8863.11368863115;9071.773205669862;9074.500902450363;9075.319351048682;9087.909120908806;1966.665666836641;2272.5682120397155;2280.600894843404;2312.54905293467;2347.9765202348012;2348.2720356689397;2355.599548076831;2358.516504116652;2360.6813080234206;2362.196853069956;2272.1933713531707;2292.6904867842795;2329.3827135809024;2332.6384410416326;2334.043042352636;1924.2687778644165;2153.870767753924;2184.6941428200066;2218.378853920905;2291.106468477295;2213.966790498144;2234.6648002799548;2254.582902163089;2261.5816074026193;2267.115824828318;9095.499747513884;9110.954445227797;9203.723888283363;9211.585478653476;9214.585343659484;5324.9733751331;5492.340919089695;5493.478119578634;5495.752691128869;5498.092814685572;3415.8975230743117;3457.429524128516;3508.842102105386;3524.4976066992467;3546.680798728101;1122.6351435783322;1165.0388429545658;1171.3089277326333;1183.177691504396;1184.9348285844276;13024.088313818036;13051.934740326333;13064.608061758163;13072.803907941388;13082.738345233041;4710.189259163163;4786.16242157621;4805.159097158054;4826.58973987215;4851.442084160296;10635.308704934154;10721.035106840422;10723.30298530593;10738.570457181782;10754;5379.1662292344745;5390.946090539044;5395.757190926339;5398.595105367113;5401.081816091274;4389.758563278986;4822.276658501253;4953.7523123844385;4962.206047032458;5040.899182016413;4033.2053420722877;4069.8168582413864;4116.629503344713;4133.81397837098;4250.213710463574;1227.7789997800303;1275.043717212091;1284.6017734502334;1288.7358091591202;1303.8891694205909;969.1519920069939;971.6647756523988;971.6987733802544;989.8911119776819;991.053543865621;5945.346011938684;5990.131430942489;5991.131285963598;6102.572819902653;6240.625562466266;419.45051981903805;421.89030851978094;427.11587014879524;1000.4547521600745;1004.6433516101824;3851.768893866377;3914.2758589661003;3995;4018.1561872007205;4299.785010749512;11412;11521.53913843437;11531.308121512737;11654.592089276835;11683.299002059734;11571.710707232218;11573.132015098901;11581.247218930743;11582.073434125417;11587.478563464665;8057.153998830156;8344.08215096339;8433.03020152678;8637.093105223861;8640.049594544595;5993.730282137227;6123.84690382744;6187.535934804818;6296.905546416899;6382.648954307372;10213.182945364502;10439.895601044196;10577.100946419332;10581.841272381074;10661.147108231478;10773.784524309627;10811.189160812813;10873.238873278795;10915.454227288763;10926.672199834018;7349.30181632744;7894.21057894206;8017.478863873829;8037.557934313435;8431.32549396059;8891.066438023914;8971.237444817263;8974.820503590023;8977.640894364153;9035.774105647411;7807.453478256468;7849.568273744999;7978.401619878417;8224.506529608243;8237.258646721824;7903.525788452481;8218.671253150047;8290;8291.626876790438;8463.069062403254;7044.15470143586;7231.132264128339;7272.163701174432;7283.708651653875;7307.269273072863;5229.398619158694;5312.468753124656;5316.787328506816;5346.518813306821;5360.115580929103;5181.119209734279;5313.920291195558;5331.546818520469;5342.332208473941;5347.759350829144 19:42:21 INFO - PROCESS | 12949 | |4;prototype.html;298.88642315919935;315.47001038255735;316.2189392201265;321.82943040188695;330.214090464694;5084.542391184793;5177.715225662587;5294.788208471661;5314.990151871142;5339.412664606895;5173.9482605173935;5202.621305354084;5203.583713302936;5231.843044708665;5259.579913423383;4076.1440097579543;4081.673466122718;4098.918021639565;4111.075008123178;4115.897102572445;3940.330143875548;3962.8216730247063;4137.8758637240935;4160.188763191179;4192.664586833046;4099.979500102495;4122;4146.44023056888;4151.730137541065;4169.958300417003;4143.958560414402;4170.207660544517;4171.958280417202;4179.623833854967;4191.601797829232;3490.4764285357146;3720.9813950930343;3724.1620635356826;3728.8694895678523;3736.0846592584717;5161.225816127611;5166.328377310963;5174.663646862942;5191.506806853343;5193.272941788153;4789.233722604401;4793.137235297645;4798.736069516175;4802.231642937113;4813.109574728652;5388.407275199725;5471.534919531845;5576.721163941827;5581.8604534886545;5590.350846500292;3991.560928297914;4016.518017837849;4023.75857448554;4044.211378781139;4055.1484188320487;5638.267025286727;5701.230333904911;5701.458361455655;5704.8859022819315;5733.655980641175;3917.373220284741;4082.7346222495444;4088.1823635273063;4089.711740801638;4093.529244136903;4062.878113656595;4090.4886889138857;4103.958960410418;4124.154548317588;4125.1749650070105;4633.2818413146015;4637.350770892078;4640.280756482751;4684.203685373494;4685.273782563708;5406.351237851483;5488.615796894179;5492.423295553989;5541.891621675681;5577.2191893135;1423.395057100728;1423.6725553122633;1431.7709166533305;1435.9230577067199;1444.714204358122;924.357571487823;935.5135329628691;940.2149205413419;957.7940742740344;963.2631037256505;4671.906561868744;4752.42970843501;4753.786079626425;4774.641901857374;4809.615230781599;5052.459000005034;5054.949450505522;5058.342415485963;5058.392992840809;5068.26313790549;4705.388299521041;4740.288956656529;4747.311639812208;4795.592374648194;4881.389826271716;2976.7916245863016;3015.54766784984;3019.022540236149;3021.425929073469;3039.978414354474;5761.452661997104;5844.824655260349;5848.853778655568;5863.970680146572;5897.7935772247765;5590.748416321276;5807.216025836458;5815.680137592389;5844.211031510777;5857.58996870215;5737.483626473638;5775.509081728016;5862.560307976833;5865.442782935615;5896.55293053378;5326.786928522971;5500.559955203654;5614.185943038318;5627.493525582717;5671.489565939085;5597.80407685729;5610.13042978339;5639.477341117958;5640.71796410186;5641.8589535261945;5834.679092649945;5835.241418615723;5852.824415267549;5855.180274761452;5889.617174883619;3587.605363410075;3747.4566187902055;3954.1696243789124;3955.525336959468;3960.386140148282;5580.274564306615;5586.525145362527;5593.748281327432;5616.326040875121;5630.127330263816;5494.423085575957;5499.1476321170285;5602.635828671123;5641.464060914206;5665.830025099253;5360.544353729977;5523.100372304572;5546.278983732089;5554.805581804618;5597.692126933058;5399.622026458111;5416.350037995308;5426.945730542802;5431.103867861917;5470.124780035176;5464.398916119144;5570.303712035996;5593.468620481211;5620.4660557247;5631.436856314336;5395.111710901153;5395.946040539544;5396.703181325065;5474.343078830566;5477.20580515815 19:42:21 INFO - PROCESS | 12949 | |5;yui.html;746.451358251685;749.1534565940486;757.6666266842589;819.7622689420065;839.0749372179764;14717.705645887088;15955.282012309444;16021.839781602195;16083.678326433494;16132.354705811782;13329.200247985103;14665.780013299809;14710.63223419415;14809.703805923875;14810.55568332949;665.0622622102836;776.5379599138532;788.9092754333268;809.1544336168718;815.0708192660372;808.2119933065273;813.259933460551;813.8453693798159;825.7564018614523;826.6486743134174;858.0989960541438;859.5487369131193;864.3992425264444;869.3783944479695;871.8866547348867;703.444279019574;827.9461834980767;860.711661593367;866.4021824940802;867.2541614211773;616.9660668663222;620.7299824576323;620.7734177025399;625.1341891480287;626.3485974586424;15214.923925380413;15380.230988450645;15420.306086226146;15468.303926323342;15470.613234669223;14300;14666.779998300033;14687.412503499847;14693;14754.114753114847;13305.268210248432;13450.798238026437;13488.12327198729;13602.251876146807;13795.310234488335;4494.8202071917085;4529.139463501924;4576.977115114437;4630.467496237909;4662.6269898408045;71169.6441517789;71934.64032679908;72803.63598182028;72942;73019;11315.886841131647;11502.137339699557;11554.942225288987;11564.76870462586;11593.594224202281;20266.088026038862;20282.79717202809;20321.085551150234;20326.085326160064;20820;9036.548172591476;9271.860922086174;9332.906670933204;9402.15380615748;9430.575624096931;4825.276208568673;4895.6083513318845;4965.875853103629;4981.850544483671;5176.197689358156;3685.1708365617524;3808.9809550952623;3815.4086116651965;3815.618438156162;3816.866409675648;550.1472717288187;645.2160624840841;656.6290046123925;664.4485077385758;676.972921083161;739.245969111514;748.3003391828657;755.4560716284267;755.9017327747358;797.2704974947858;9775.853362199572;9991.550380232908;10214.438205898598;10272.640457584099;10402.635907743193;646.9385408386196;716.1907045039072;740.8925705772633;753.4800987318732;768.9158286815675;4767.976160119247;5035;5057.468965758616;5062.341895553628;5071.5689166420525;88140.55929720438;89986.55006724925;90959.5452022749;108431;129156.35421822831;92598.53700731453;93081;93120.53439732757;94464.52767736117;95514.52242738742;83386;83814;85556.57221713851;86047.13952860517;89340.5532972331;9718.805623887623;9817.067378599022;9872.605095796087;9928.950355248178;9943.602255909682;49136.262956054976;49322.75338623284;49723.75138124286;50440.49559504358;50896.655851135096;45405.54594454145;47750.76124619355;71790;72600;73260.63369683118;12342.321172335249;12691.93654031724;12713.173643713499;12937.805932911202;13394;14681.779773303195;14853.48012819546;15660;15773.211339432753;15945;13873.930630347188;13929.164250145024;14338.56984290473;14402.20787856678;14412.13527188372;14693.632659183606;14718;14722.116672999655;15242.618934526725;15274.770878437055;13345.933270333586;13891.72216555643;14040.648983775487;14048.297585120907;14534.56804268023;11169.944150279196;11237.887621123684;11636.476358563716;11639.359835209145;11878.287302761863;11100.61147859821;11349.659510214708;11490.88509114898;11580.884191158317;11930.284182949052 19:42:21 INFO - PROCESS | 12949 | __end_tp_report 19:42:21 INFO - PROCESS | 12949 | __start_cc_report 19:42:21 INFO - PROCESS | 12949 | _x_x_mozilla_cycle_collect,1019 19:42:21 INFO - PROCESS | 12949 | __end_cc_report 19:42:21 INFO - PROCESS | 12949 | __startTimestamp1466649741129__endTimestamp 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | ------- Summary: start ------- 19:42:21 INFO - PROCESS | 12949 | Number of tests: 6 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | [#0] dojo.html Cycles:165 Average:5362.70 Median:5584.13 stddev:625.82 (11.2%) stddev-sans-first:601.20 19:42:21 INFO - PROCESS | 12949 | Values: 3064.3 3080.9 3081.2 3098.6 3130.5 5290.7 5326.5 5395.5 5421.6 5449.8 5305.7 5332.1 5443.2 5467.3 5469.9 4786.5 4866.3 4879.7 4896.2 5121.9 4997.3 5012.6 5049.8 5072.1 5081.2 4772.4 4799.6 4815.5 4851.1 4875.8 4879.3 4901.3 4906.0 4945.7 4997.7 4908.7 4934.4 4950.9 4951.8 4998.1 5229.1 5291.5 5321.0 5324.0 5366.9 5755.8 5793.5 5819.0 5841.6 5877.4 5677.5 5839.9 5860.9 5927.2 5931.2 5296.9 5351.1 5362.9 5445.1 5451.8 5930.4 5938.7 5942.1 5943.3 5945.5 5435.9 5674.4 5691.8 5692.7 5716.4 5546.3 5611.9 5614.4 5615.5 5634.5 5584.1 5608.4 5633.4 5640.4 5643.1 5547.3 5578.1 5631.2 5632.4 5642.4 4319.8 4350.6 4354.7 4383.4 4392.8 3852.9 3874.2 3879.3 3886.7 3909.2 5243.8 5252.2 5309.1 5350.5 5356.9 5765.2 5806.7 5835.1 5866.7 5891.0 5423.7 5436.0 5438.6 5443.5 5445.3 4902.0 5013.1 5042.4 5047.8 5094.8 6007.4 6087.1 6091.1 6095.8 6142.8 5915.3 5932.6 5934.2 5935.3 5938.5 5747.0 5918.8 5985.9 6071.8 6088.7 5695.3 5717.1 5717.3 5722.9 5783.5 5866.4 5866.4 5871.5 5872.3 5881.2 5489.9 5652.4 5676.5 5713.6 5731.6 5738.2 5746.6 5748.3 5748.8 5750.1 5606.6 5624.4 5624.7 5624.9 5625.2 5561.5 5604.4 5674.5 5678.7 5785.3 5516.5 5590.6 5592.9 5615.3 5621.7 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | [#1] ext.html Cycles:180 Average:60215.22 Median:41707.69 stddev:119262.83 (285.9%) stddev-sans-first:119513.38 19:42:21 INFO - PROCESS | 12949 | Values: 593.5 608.8 614.9 616.8 641.9 30359.8 31049.5 41143.4 42386.6 42465.8 41312.4 45863.8 45988.3 46058.8 46064.3 8903.4 9065.5 9066.8 9082.1 9091.9 8839.1 8954.0 8956.5 8958.2 8961.9 9014.5 9034.7 9043.4 9046.7 9048.6 8984.3 9027.3 9029.0 9029.9 9038.8 8909.3 8923.9 8976.7 8983.9 8985.8 41821.4 42767.6 42788.9 42791.6 42834.6 3666.6 3956.6 3980.0 3984.2 4078.1 32047.8 32535.2 32739.0 32954.8 34020.5 4418.9 4504.5 4518.7 4519.7 4620.0 348565.0 352616.0 353505.0 353712.0 354420.0 57575.4 57664.7 57905.0 57988.7 58025.4 60950.7 61018.4 61039.7 61072.4 61222.4 14173.6 14331.2 14340.6 14362.5 14367.7 11768.9 11880.7 11892.3 11893.4 11895.3 15208.7 16019.3 16354.3 16401.8 16413.9 5217.9 6049.7 6078.9 6143.9 6267.3 1047.8 1062.5 1074.0 1101.0 1103.3 32199.2 32209.4 32380.2 32579.5 32656.5 1065.5 1075.2 1093.3 1169.6 1192.4 17155.7 17164.7 17238.8 17361.0 17383.1 555312.0 559749.0 562254.0 563953.0 565067.0 59735.0 59901.1 59998.0 60113.0 60237.4 1233.1 1320.6 1347.1 1357.8 1386.1 23621.8 23790.0 23799.2 24122.8 24155.0 49978.5 50095.5 50194.5 50383.7 50665.7 403940.0 408194.0 408848.0 409021.0 409663.0 34067.7 39303.4 41014.0 41395.4 41638.0 48675.0 48949.3 49524.5 50070.2 50254.2 41169.6 41471.4 41818.6 42511.6 43162.8 41160.0 41855.8 42222.0 42375.4 42773.4 40569.4 40851.2 41670.0 41680.0 41735.4 34156.0 36858.4 37287.6 37630.4 37699.8 27141.3 27508.9 27763.0 29587.9 29822.1 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | [#2] jquery.html Cycles:180 Average:28832.28 Median:2681.90 stddev:80682.18 (3008.4%) stddev-sans-first:80880.25 19:42:21 INFO - PROCESS | 12949 | Values: 388.5 390.3 395.5 397.5 415.9 14093.4 16897.4 18908.8 19570.4 19577.4 14774.5 15041.9 17522.2 18887.8 18956.1 4773.2 5127.2 5133.3 5169.8 5175.1 5041.0 5104.8 5309.2 5609.8 5653.3 5717.3 5731.6 5734.9 5755.5 5755.5 5133.4 5264.1 5268.8 5297.9 5728.7 5072.7 5103.0 5110.4 5114.2 5127.1 13490.2 14350.3 14353.9 14354.1 14355.7 2403.6 2443.0 2651.5 2712.3 2741.7 10163.7 10329.4 10335.1 10521.6 10748.1 1825.5 1963.3 1967.3 1975.2 1991.2 80028.6 84617.2 85117.6 85291.0 86095.0 10568.9 10713.8 10757.7 10970.2 11168.8 15407.8 15556.5 15560.3 15574.7 15580.1 6695.0 7158.3 7524.8 7625.9 7887.3 7465.0 7505.5 7595.3 7608.2 7730.1 4451.2 4531.6 4672.4 4799.4 4899.8 1882.4 1924.0 1969.4 1969.6 1978.5 909.4 976.8 998.6 1059.6 1060.3 19430.8 19465.5 19544.2 19592.0 19892.4 968.5 990.8 992.7 995.4 1036.5 10328.2 10825.5 10869.3 10918.8 10949.3 479044.0 481262.0 490623.0 495197.0 495986.0 82673.6 83169.0 83804.0 98737.0 100382.5 1000.2 1031.5 1037.5 1039.1 1048.2 17165.6 17376.9 18240.0 18272.9 18432.4 43254.4 44292.0 44310.3 44541.6 44926.6 61300.4 61704.0 62574.4 62633.0 63324.4 8818.6 8980.7 9029.4 9029.8 9033.5 10156.9 12643.8 13774.0 13817.5 14012.6 11850.2 11955.3 11996.8 12120.6 12500.6 11960.6 11967.9 12123.0 12139.9 12290.3 10551.7 12305.6 12472.7 12596.9 12630.4 8797.6 8871.1 9123.4 9233.9 9259.3 8972.5 11959.9 12141.2 12294.1 12423.1 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | [#3] mootools.html Cycles:180 Average:6002.15 Median:4549.97 stddev:3515.79 (77.3%) stddev-sans-first:3508.21 19:42:21 INFO - PROCESS | 12949 | Values: 1341.9 1485.3 1520.6 1624.8 1795.9 8414.1 8838.0 8845.6 9135.1 9145.9 8863.1 9071.8 9074.5 9075.3 9087.9 1966.7 2272.6 2280.6 2312.5 2348.0 2348.3 2355.6 2358.5 2360.7 2362.2 2272.2 2292.7 2329.4 2332.6 2334.0 1924.3 2153.9 2184.7 2218.4 2291.1 2214.0 2234.7 2254.6 2261.6 2267.1 9095.5 9111.0 9203.7 9211.6 9214.6 5325.0 5492.3 5493.5 5495.8 5498.1 3415.9 3457.4 3508.8 3524.5 3546.7 1122.6 1165.0 1171.3 1183.2 1184.9 13024.1 13051.9 13064.6 13072.8 13082.7 4710.2 4786.2 4805.2 4826.6 4851.4 10635.3 10721.0 10723.3 10738.6 10754.0 5379.2 5390.9 5395.8 5398.6 5401.1 4389.8 4822.3 4953.8 4962.2 5040.9 4033.2 4069.8 4116.6 4133.8 4250.2 1227.8 1275.0 1284.6 1288.7 1303.9 969.2 971.7 971.7 989.9 991.1 5945.3 5990.1 5991.1 6102.6 6240.6 419.5 421.9 427.1 1000.5 1004.6 3851.8 3914.3 3995.0 4018.2 4299.8 11412.0 11521.5 11531.3 11654.6 11683.3 11571.7 11573.1 11581.2 11582.1 11587.5 8057.2 8344.1 8433.0 8637.1 8640.0 5993.7 6123.8 6187.5 6296.9 6382.6 10213.2 10439.9 10577.1 10581.8 10661.1 10773.8 10811.2 10873.2 10915.5 10926.7 7349.3 7894.2 8017.5 8037.6 8431.3 8891.1 8971.2 8974.8 8977.6 9035.8 7807.5 7849.6 7978.4 8224.5 8237.3 7903.5 8218.7 8290.0 8291.6 8463.1 7044.2 7231.1 7272.2 7283.7 7307.3 5229.4 5312.5 5316.8 5346.5 5360.1 5181.1 5313.9 5331.5 5342.3 5347.8 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | [#4] prototype.html Cycles:180 Average:4608.37 Median:5184.61 stddev:1347.51 (26.0%) stddev-sans-first:1311.90 19:42:21 INFO - PROCESS | 12949 | Values: 298.9 315.5 316.2 321.8 330.2 5084.5 5177.7 5294.8 5315.0 5339.4 5173.9 5202.6 5203.6 5231.8 5259.6 4076.1 4081.7 4098.9 4111.1 4115.9 3940.3 3962.8 4137.9 4160.2 4192.7 4100.0 4122.0 4146.4 4151.7 4170.0 4144.0 4170.2 4172.0 4179.6 4191.6 3490.5 3721.0 3724.2 3728.9 3736.1 5161.2 5166.3 5174.7 5191.5 5193.3 4789.2 4793.1 4798.7 4802.2 4813.1 5388.4 5471.5 5576.7 5581.9 5590.4 3991.6 4016.5 4023.8 4044.2 4055.1 5638.3 5701.2 5701.5 5704.9 5733.7 3917.4 4082.7 4088.2 4089.7 4093.5 4062.9 4090.5 4104.0 4124.2 4125.2 4633.3 4637.4 4640.3 4684.2 4685.3 5406.4 5488.6 5492.4 5541.9 5577.2 1423.4 1423.7 1431.8 1435.9 1444.7 924.4 935.5 940.2 957.8 963.3 4671.9 4752.4 4753.8 4774.6 4809.6 5052.5 5054.9 5058.3 5058.4 5068.3 4705.4 4740.3 4747.3 4795.6 4881.4 2976.8 3015.5 3019.0 3021.4 3040.0 5761.5 5844.8 5848.9 5864.0 5897.8 5590.7 5807.2 5815.7 5844.2 5857.6 5737.5 5775.5 5862.6 5865.4 5896.6 5326.8 5500.6 5614.2 5627.5 5671.5 5597.8 5610.1 5639.5 5640.7 5641.9 5834.7 5835.2 5852.8 5855.2 5889.6 3587.6 3747.5 3954.2 3955.5 3960.4 5580.3 5586.5 5593.7 5616.3 5630.1 5494.4 5499.1 5602.6 5641.5 5665.8 5360.5 5523.1 5546.3 5554.8 5597.7 5399.6 5416.4 5426.9 5431.1 5470.1 5464.4 5570.3 5593.5 5620.5 5631.4 5395.1 5395.9 5396.7 5474.3 5477.2 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - PROCESS | 12949 | [#5] yui.html Cycles:180 Average:19988.15 Median:49229.51 stddev:27625.05 (56.1%) stddev-sans-first:27664.76 19:42:21 INFO - PROCESS | 12949 | Values: 746.5 749.2 757.7 819.8 839.1 14717.7 15955.3 16021.8 16083.7 16132.4 13329.2 14665.8 14710.6 14809.7 14810.6 665.1 776.5 788.9 809.2 815.1 808.2 813.3 813.8 825.8 826.6 858.1 859.5 864.4 869.4 871.9 703.4 827.9 860.7 866.4 867.3 617.0 620.7 620.8 625.1 626.3 15214.9 15380.2 15420.3 15468.3 15470.6 14300.0 14666.8 14687.4 14693.0 14754.1 13305.3 13450.8 13488.1 13602.3 13795.3 4494.8 4529.1 4577.0 4630.5 4662.6 71169.6 71934.6 72803.6 72942.0 73019.0 11315.9 11502.1 11554.9 11564.8 11593.6 20266.1 20282.8 20321.1 20326.1 20820.0 9036.5 9271.9 9332.9 9402.2 9430.6 4825.3 4895.6 4965.9 4981.9 5176.2 3685.2 3809.0 3815.4 3815.6 3816.9 550.1 645.2 656.6 664.4 677.0 739.2 748.3 755.5 755.9 797.3 9775.9 9991.6 10214.4 10272.6 10402.6 646.9 716.2 740.9 753.5 768.9 4768.0 5035.0 5057.5 5062.3 5071.6 88140.6 89986.6 90959.5 108431.0 129156.4 92598.5 93081.0 93120.5 94464.5 95514.5 83386.0 83814.0 85556.6 86047.1 89340.6 9718.8 9817.1 9872.6 9929.0 9943.6 49136.3 49322.8 49723.8 50440.5 50896.7 45405.5 47750.8 71790.0 72600.0 73260.6 12342.3 12691.9 12713.2 12937.8 13394.0 14681.8 14853.5 15660.0 15773.2 15945.0 13873.9 13929.2 14338.6 14402.2 14412.1 14693.6 14718.0 14722.1 15242.6 15274.8 13345.9 13891.7 14040.6 14048.3 14534.6 11169.9 11237.9 11636.5 11639.4 11878.3 11100.6 11349.7 11490.9 11580.9 11930.3 19:42:21 INFO - PROCESS | 12949 | -------- Summary: end -------- 19:42:21 INFO - PROCESS | 12949 | 19:42:21 INFO - TEST-INFO | 12949: exit 0 19:42:21 INFO - TEST-OK | dromaeo_css | took 1115241ms 19:42:21 INFO - TEST-START | kraken 19:42:21 INFO - operating with platform_type : linux_ 19:42:21 INFO - Initialising browser for kraken test... 19:42:21 INFO - TEST-INFO | started process 13133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRqTJE/profile http://localhost:48581/getInfo.html) 19:42:26 INFO - PROCESS | 13133 | __metrics Screen width/height:1600/1200 19:42:26 INFO - PROCESS | 13133 | colorDepth:24 19:42:26 INFO - PROCESS | 13133 | Browser inner width/height: 1024/697 19:42:26 INFO - PROCESS | 13133 | __metrics 19:42:27 INFO - PROCESS | 13133 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:42:28 INFO - TEST-INFO | 13133: exit 0 19:42:28 INFO - Browser initialized. 19:42:28 INFO - Running cycle 1/1 for kraken test... 19:42:28 INFO - TEST-INFO | started process 13215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRqTJE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:40 INFO - PROCESS | 13215 | RSS: Main: 173756416 19:42:40 INFO - PROCESS | 13215 | 19:42:43 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-beat-detection) 19:42:44 INFO - PROCESS | 13215 | RSS: Main: 232562688 19:42:44 INFO - PROCESS | 13215 | 19:42:46 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-dft) 19:42:47 INFO - PROCESS | 13215 | RSS: Main: 221638656 19:42:47 INFO - PROCESS | 13215 | 19:42:50 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-fft) 19:42:51 INFO - PROCESS | 13215 | RSS: Main: 286687232 19:42:51 INFO - PROCESS | 13215 | 19:42:53 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48581/tests/kraken/driver.html?testName=audio-oscillator) 19:42:53 INFO - PROCESS | 13215 | RSS: Main: 197931008 19:42:53 INFO - PROCESS | 13215 | 19:42:56 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:42:56 INFO - PROCESS | 13215 | RSS: Main: 202350592 19:42:56 INFO - PROCESS | 13215 | 19:42:59 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-darkroom) 19:43:00 INFO - PROCESS | 13215 | RSS: Main: 238059520 19:43:00 INFO - PROCESS | 13215 | 19:43:03 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48581/tests/kraken/driver.html?testName=imaging-desaturate) 19:43:04 INFO - PROCESS | 13215 | RSS: Main: 233836544 19:43:04 INFO - PROCESS | 13215 | 19:43:07 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48581/tests/kraken/driver.html?testName=json-parse-financial) 19:43:07 INFO - PROCESS | 13215 | RSS: Main: 236900352 19:43:07 INFO - PROCESS | 13215 | 19:43:09 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:09 INFO - PROCESS | 13215 | RSS: Main: 225636352 19:43:09 INFO - PROCESS | 13215 | 19:43:11 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:12 INFO - PROCESS | 13215 | RSS: Main: 229486592 19:43:12 INFO - PROCESS | 13215 | 19:43:14 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:15 INFO - PROCESS | 13215 | RSS: Main: 235438080 19:43:15 INFO - PROCESS | 13215 | 19:43:17 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:43:18 INFO - PROCESS | 13215 | RSS: Main: 239407104 19:43:18 INFO - PROCESS | 13215 | 19:43:20 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:43:21 INFO - PROCESS | 13215 | RSS: Main: 239542272 19:43:21 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | Cycle 1(1): loaded http://localhost:48581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48581/tests/kraken/driver.html?testName=ai-astar) 19:43:23 INFO - PROCESS | 13215 | RSS: Main: 282210304 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | __start_tp_report 19:43:23 INFO - PROCESS | 13215 | _x_x_mozilla_page_load 19:43:23 INFO - PROCESS | 13215 | _x_x_mozilla_page_load_details 19:43:23 INFO - PROCESS | 13215 | |i|pagename|runs| 19:43:23 INFO - PROCESS | 13215 | |0;ai-astar;101;111;111;110;110;111;110;110;111;109 19:43:23 INFO - PROCESS | 13215 | |1;audio-beat-detection;153;132;127;179;126;127;157;126;159;138 19:43:23 INFO - PROCESS | 13215 | |2;audio-dft;161;162;160;160;159;161;160;164;160;160 19:43:23 INFO - PROCESS | 13215 | |3;audio-fft;75;75;74;126;75;75;74;74;100;74 19:43:23 INFO - PROCESS | 13215 | |4;audio-oscillator;85;85;124;85;85;85;121;84;85;125 19:43:23 INFO - PROCESS | 13215 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;117;116 19:43:23 INFO - PROCESS | 13215 | |6;imaging-darkroom;145;145;146;154;147;146;146;146;146;146 19:43:23 INFO - PROCESS | 13215 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 19:43:23 INFO - PROCESS | 13215 | |8;json-parse-financial;53;54;54;52;53;53;53;53;53;53 19:43:23 INFO - PROCESS | 13215 | |9;json-stringify-tinderbox;64;63;63;64;63;63;63;64;64;64 19:43:23 INFO - PROCESS | 13215 | |10;stanford-crypto-aes;78;82;84;78;79;80;87;80;92;80 19:43:23 INFO - PROCESS | 13215 | |11;stanford-crypto-ccm;131;122;134;120;126;120;126;120;132;124 19:43:23 INFO - PROCESS | 13215 | |12;stanford-crypto-pbkdf2;159;163;162;160;159;160;158;163;159;158 19:43:23 INFO - PROCESS | 13215 | |13;stanford-crypto-sha256-iterative;64;63;62;63;61;62;63;61;62;62 19:43:23 INFO - PROCESS | 13215 | __end_tp_report 19:43:23 INFO - PROCESS | 13215 | __start_cc_report 19:43:23 INFO - PROCESS | 13215 | _x_x_mozilla_cycle_collect,1623 19:43:23 INFO - PROCESS | 13215 | __end_cc_report 19:43:23 INFO - PROCESS | 13215 | __startTimestamp1466649803368__endTimestamp 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | ------- Summary: start ------- 19:43:23 INFO - PROCESS | 13215 | Number of tests: 14 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:3.03 (2.7%) stddev-sans-first:0.71 19:43:23 INFO - PROCESS | 13215 | Values: 101.0 111.0 111.0 110.0 110.0 111.0 110.0 110.0 111.0 109.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:145.50 stddev:18.50 (12.7%) stddev-sans-first:19.22 19:43:23 INFO - PROCESS | 13215 | Values: 153.0 132.0 127.0 179.0 126.0 127.0 157.0 126.0 159.0 138.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.42 (0.9%) stddev-sans-first:1.50 19:43:23 INFO - PROCESS | 13215 | Values: 161.0 162.0 160.0 160.0 159.0 161.0 160.0 164.0 160.0 160.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:17.36 (23.3%) stddev-sans-first:18.21 19:43:23 INFO - PROCESS | 13215 | Values: 75.0 75.0 74.0 126.0 75.0 75.0 74.0 74.0 100.0 74.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:85.00 stddev:18.61 (21.9%) stddev-sans-first:19.28 19:43:23 INFO - PROCESS | 13215 | Values: 85.0 85.0 124.0 85.0 85.0 85.0 121.0 84.0 85.0 125.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:43:23 INFO - PROCESS | 13215 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.00 stddev:2.63 (1.8%) stddev-sans-first:2.71 19:43:23 INFO - PROCESS | 13215 | Values: 145.0 145.0 146.0 154.0 147.0 146.0 146.0 146.0 146.0 146.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:43:23 INFO - PROCESS | 13215 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 19:43:23 INFO - PROCESS | 13215 | Values: 53.0 54.0 54.0 52.0 53.0 53.0 53.0 53.0 53.0 53.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:43:23 INFO - PROCESS | 13215 | Values: 64.0 63.0 63.0 64.0 63.0 63.0 63.0 64.0 64.0 64.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:4.50 (5.6%) stddev-sans-first:4.53 19:43:23 INFO - PROCESS | 13215 | Values: 78.0 82.0 84.0 78.0 79.0 80.0 87.0 80.0 92.0 80.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:5.28 (4.2%) stddev-sans-first:5.21 19:43:23 INFO - PROCESS | 13215 | Values: 131.0 122.0 134.0 120.0 126.0 120.0 126.0 120.0 132.0 124.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:1.91 (1.2%) stddev-sans-first:1.99 19:43:23 INFO - PROCESS | 13215 | Values: 159.0 163.0 162.0 160.0 159.0 160.0 158.0 163.0 159.0 158.0 19:43:23 INFO - PROCESS | 13215 | 19:43:23 INFO - PROCESS | 13215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:0.95 (1.5%) stddev-sans-first:0.78 19:43:23 INFO - PROCESS | 13215 | Values: 64.0 63.0 62.0 63.0 61.0 62.0 63.0 61.0 62.0 62.0 19:43:23 INFO - PROCESS | 13215 | -------- Summary: end -------- 19:43:23 INFO - PROCESS | 13215 | 19:43:24 INFO - TEST-INFO | 13215: exit 0 19:43:24 INFO - TEST-OK | kraken | took 62495ms 19:43:24 INFO - SUITE-END | took 1177s 19:43:24 INFO - Completed test suite (00:19:37) 19:43:24 INFO - javascript benchmark 19:43:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.2952121012167, 3080.9229769255767, 3081.245094951737, 3098.597182366295, 3130.4521708700972, 5290.709011004393, 5326.520613144816, 5395.514403703666, 5421.647592906464, 5449.809256676017, 5305.734713264341, 5332.14685650296, 5443.156310771837, 5467.316585426822, 5469.890602187954, 4786.521347865212, 4866.270059491069, 4879.6828206166665, 4896.216605343146, 5121.923171152435, 4997.250412438145, 5012.624053196025, 5049.8485045448515, 5072.137736584789, 5081.237814327844, 4772.3795906532105, 4799.616030717569, 4815.518448155191, 4851.10254602896, 4875.829345972874, 4879.268109783561, 4901.313816065754, 4906.018796240731, 4945.727984960826, 4997.725125118117, 4908.7300198489065, 4934.40787105546, 4950.87622809429, 4951.801927922878, 4998.075356059141, 5229.11105112128, 5291.497307755757, 5321.042212401766, 5323.96182744365, 5366.91949620756, 5755.798547050833, 5793.507551858097, 5819.0, 5841.591088623798, 5877.441643043904, 5677.489025987681, 5839.883202335929, 5860.853478663025, 5927.199828023205, 5931.228940237785, 5296.894062118736, 5351.143816989302, 5362.865928351784, 5445.101558242845, 5451.8364449066985, 5930.436608522184, 5938.703064846741, 5942.108683697394, 5943.257092863392, 5945.524358051345, 5435.8856434430845, 5674.375818659944, 5691.77232910679, 5692.715364231854, 5716.42835716425, 5546.27898373217, 5611.859703507445, 5614.410486898899, 5615.522680572197, 5634.52106570946, 5584.134459158837, 5608.439156084359, 5633.352164501053, 5640.435956404409, 5643.125315576092, 5547.33431988164, 5578.107502799614, 5631.183478395692, 5632.408597097327, 5642.407547207484, 4319.848805291863, 4350.60844523988, 4354.6951713380395, 4383.430154080013, 4392.846250381285, 3852.903677408031, 3874.1670540833857, 3879.301725689403, 3886.6696330811633, 3909.159530700913, 5243.764030618631, 5252.159654455345, 5309.070912590281, 5350.545203657655, 5356.8660783479945, 5765.1640512125505, 5806.65160090396, 5835.124731290341, 5866.67733274674, 5891.0, 5423.701696406735, 5436.0, 5438.564914806885, 5443.510084092451, 5445.264889239902, 4902.044101400193, 5013.1227035268685, 5042.39491261051, 5047.823326183566, 5094.847154585368, 6007.429294217042, 6087.056506241451, 6091.055886337536, 6095.8476038098515, 6142.78500252489, 5915.260592425947, 5932.644041357532, 5934.169216309634, 5935.347111817783, 5938.465538101592, 5747.023006088892, 5918.822435326947, 5985.910211346746, 6071.787487437919, 6088.665123418077, 5695.316562012585, 5717.113847353667, 5717.285339332583, 5722.914156287576, 5783.508401785895, 5866.3547009828035, 5866.354700982974, 5871.500922421642, 5872.324682661549, 5881.17663527098, 5489.862753431196, 5652.378238393691, 5676.545876329967, 5713.571482138773, 5731.598788084794, 5738.1679656450415, 5746.569007324551, 5748.252727145445, 5748.770049197985, 5750.13747937796, 5606.551475881838, 5624.437556244343, 5624.690642014729, 5624.859378515406, 5625.212470254086, 5561.499465048003, 5604.411536788579, 5674.517665998271, 5678.716064196857, 5785.334686510937, 5516.475934786189, 5590.5527557796095, 5592.944070559242, 5615.2700148980375, 5621.662700237999], "value": 5319.261974446475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.5014587746292, 608.777796104422, 614.8708771158057, 616.7594638091144, 641.8523739539905, 30359.848200758992, 31049.534256986164, 41143.38284925725, 42386.57613423865, 42465.78767106168, 41312.38031429531, 45863.770681146634, 45988.3101753474, 46058.76970615142, 46064.309035364415, 8903.376763626533, 9065.546722663874, 9066.77333066672, 9082.09179082093, 9091.909080909205, 8839.07189745074, 8954.0, 8956.507392093432, 8958.23854972328, 8961.865572016392, 9014.504202268872, 9034.68378606749, 9043.412178208428, 9046.683366082156, 9048.592813323383, 8984.281257499384, 9027.277817774628, 9028.954855225682, 9029.909700902972, 9038.774030649254, 8909.331800114953, 8923.910760892373, 8976.730698079067, 8983.865242021375, 8985.775355616162, 41821.37267940983, 42767.57232427667, 42788.9350511704, 42791.57208427907, 42834.57165428368, 3666.633336666312, 3956.5845586213322, 3980.044789250588, 3984.183242435294, 4078.082431452929, 32047.839760801045, 32535.186620334443, 32739.0, 32954.835225823954, 34020.48969265463, 4418.911621767579, 4504.459464864237, 4518.728876267402, 4519.706219095749, 4619.976900115478, 348565.0, 352616.0, 353505.0, 353712.0, 354420.0, 57575.424245757844, 57664.71167644135, 57905.0, 57988.71005645029, 58025.41974580284, 60950.695246523486, 61018.38981610216, 61039.675238971606, 61072.38927610756, 61222.38777612256, 14173.645658858404, 14331.211783352015, 14340.641483962776, 14362.497312594009, 14367.712645747026, 11768.94115529417, 11880.702982425508, 11892.286462812259, 11893.40532973348, 11895.345755983504, 15208.695826083416, 16019.279132439067, 16354.34582616682, 16401.83598164027, 16413.91793041051, 5217.869553261199, 6049.667268300285, 6078.936186167403, 6143.938560614337, 6267.2792628848265, 1047.8323468245044, 1062.5263523400818, 1073.9797192666997, 1100.9779804404027, 1103.3435106111851, 32199.195020124214, 32209.355812883612, 32380.190495237806, 32579.51130733041, 32656.510152347735, 1065.5311662868314, 1075.1613741281813, 1093.3002878157986, 1169.5964892112208, 1192.4037981009494, 17155.656886862194, 17164.742528862076, 17238.827611723973, 17361.0, 17383.0855175775, 555312.0, 559749.0, 562254.0, 563953.0, 565067.0, 59735.0, 59901.10148347778, 59998.0, 60113.0, 60237.39762602405, 1233.105998151351, 1320.630223537411, 1347.1109068015062, 1357.7963305504056, 1386.0921096681689, 23621.763782361955, 23790.0, 23799.167029153898, 24122.75877241205, 24155.03379864856, 49978.50021499739, 50095.499045009085, 50194.49805501898, 50383.74808125936, 50665.74667126641, 403940.0, 408194.0, 408848.0, 409021.0, 409663.0, 34067.65932340645, 39303.41044884272, 41014.0, 41395.379069314586, 41638.0, 48675.0, 48949.26576101433, 49524.50475495199, 50070.24894626511, 50254.246186307966, 41169.58830411657, 41471.37792933048, 41818.58181418269, 42511.57488425076, 43162.78418607887, 41160.0, 41855.790721047415, 42222.0, 42375.3643695351, 42773.35839962465, 40569.391459127546, 40851.182976340904, 41670.0, 41680.0, 41735.37396939109, 34156.0, 36858.44712329264, 37287.6271237295, 37630.435543467414, 37699.81150094232, 27141.321466963484, 27508.862455687595, 27763.0, 29587.85206073956, 29822.10533683993], "value": 19995.205612708487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.5337594886137, 390.2526661443338, 395.51746868820067, 397.5289282200592, 415.8710799652108, 14093.436262549485, 16897.408590699328, 18908.810911890876, 19570.412887613376, 19577.412677619657, 14774.482893098744, 15041.924790376033, 17522.211500482477, 18887.811121888775, 18956.052197390145, 4773.236282194849, 5127.179651255799, 5133.255677926699, 5169.819056333029, 5175.094358487268, 5040.97479512602, 5104.77028533715, 5309.203619457074, 5609.80365687201, 5653.265075540174, 5717.285339332583, 5731.598788084836, 5734.942650573504, 5755.510781583549, 5755.510781583571, 5133.435322114565, 5264.078786212397, 5268.789248430058, 5297.947020529784, 5728.742206600713, 5072.72100034498, 5103.030424219386, 5110.361204849394, 5114.232865070269, 5127.102757017507, 13490.190588564717, 14350.282485875665, 14353.85646143546, 14354.066985645899, 14355.712885742227, 2403.579373609629, 2442.963355549668, 2651.456451427472, 2712.34903623131, 2741.739534744196, 10163.745906352326, 10329.380237185793, 10335.121514671262, 10521.579136834518, 10748.140148788078, 1825.5071130794745, 1963.2834015584351, 1967.2622766462578, 1975.1704284200528, 1991.153759652142, 80028.59985700093, 84617.15382846216, 85117.57441212816, 85291.0, 86094.99999999937, 10568.947155264175, 10713.83929241062, 10757.677269681923, 10970.244760838228, 11168.776624467466, 15407.845921540642, 15556.455524056604, 15560.299786509635, 15574.688506229812, 15580.143092130042, 6694.966525167343, 7158.2841715828, 7524.774256772305, 7625.923740762521, 7887.329576985906, 7464.962675186589, 7505.4746167767735, 7595.278448547379, 7608.2391760823475, 7730.149683534807, 4451.198784218872, 4531.56950089741, 4672.369230153886, 4799.400074990626, 4899.779509922062, 1882.444678819724, 1924.0, 1969.4363423329153, 1969.5666953270259, 1978.455924620712, 909.377076702461, 976.8241716490958, 998.6255154317131, 1059.586761163147, 1060.3002018667642, 19430.848658613533, 19465.513362165777, 19544.218231270876, 19592.0, 19892.403227903185, 968.5496244246459, 990.8365119755159, 992.7220378294089, 995.3778888194878, 1036.522954789422, 10328.173746100294, 10825.458727063615, 10869.34783912952, 10918.836217456745, 10949.33197378887, 479044.0, 481262.0, 490623.0, 495197.0, 495986.0, 82673.58663206766, 83169.0, 83804.0, 98737.0, 100382.4980875091, 1000.229823036258, 1031.4739482863793, 1037.5071840875676, 1039.0648416425279, 1048.1771809129796, 17165.57086072858, 17376.91311543434, 18240.0, 18272.908635456737, 18432.354867579572, 43254.351184731626, 44292.0, 44310.33534496921, 44541.55458445374, 44926.55073449355, 61300.38699612947, 61704.0, 62574.37425625685, 62633.0, 63324.36675633369, 8818.603162857558, 8980.730578082668, 9029.419851526089, 9029.819403612022, 9033.457992520469, 10156.89843101589, 12643.810342844681, 13774.0, 13817.51638692681, 14012.579622611338, 11850.229735067192, 11955.282683039046, 11996.820047699117, 12120.575779847662, 12500.562480313145, 11960.58137965167, 11967.940160299491, 12123.0, 12139.939300303442, 12290.262584244616, 10551.683449496528, 12305.56930507428, 12472.688182795502, 12596.937015314865, 12630.368481576068, 8797.604107815292, 8871.112888711077, 9123.361364704408, 9233.861492077758, 9259.305552083486, 8972.461652300883, 11959.880401196224, 12141.150119491904, 12294.077944154045, 12423.130380873252], "value": 9052.724560837389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.912775669582, 1485.279639374903, 1520.5742392130203, 1624.7969003874516, 1795.8742887997846, 8414.116517765638, 8838.0, 8845.601947912342, 9135.086491350861, 9145.862812057809, 8863.11368863115, 9071.773205669862, 9074.500902450363, 9075.319351048682, 9087.909120908806, 1966.665666836641, 2272.5682120397155, 2280.600894843404, 2312.54905293467, 2347.9765202348012, 2348.2720356689397, 2355.599548076831, 2358.516504116652, 2360.6813080234206, 2362.196853069956, 2272.1933713531707, 2292.6904867842795, 2329.3827135809024, 2332.6384410416326, 2334.043042352636, 1924.2687778644165, 2153.870767753924, 2184.6941428200066, 2218.378853920905, 2291.106468477295, 2213.966790498144, 2234.6648002799548, 2254.582902163089, 2261.5816074026193, 2267.115824828318, 9095.499747513884, 9110.954445227797, 9203.723888283363, 9211.585478653476, 9214.585343659484, 5324.9733751331, 5492.340919089695, 5493.478119578634, 5495.752691128869, 5498.092814685572, 3415.8975230743117, 3457.429524128516, 3508.842102105386, 3524.4976066992467, 3546.680798728101, 1122.6351435783322, 1165.0388429545658, 1171.3089277326333, 1183.177691504396, 1184.9348285844276, 13024.088313818036, 13051.934740326333, 13064.608061758163, 13072.803907941388, 13082.738345233041, 4710.189259163163, 4786.16242157621, 4805.159097158054, 4826.58973987215, 4851.442084160296, 10635.308704934154, 10721.035106840422, 10723.30298530593, 10738.570457181782, 10754.0, 5379.1662292344745, 5390.946090539044, 5395.757190926339, 5398.595105367113, 5401.081816091274, 4389.758563278986, 4822.276658501253, 4953.7523123844385, 4962.206047032458, 5040.899182016413, 4033.2053420722877, 4069.8168582413864, 4116.629503344713, 4133.81397837098, 4250.213710463574, 1227.7789997800303, 1275.043717212091, 1284.6017734502334, 1288.7358091591202, 1303.8891694205909, 969.1519920069939, 971.6647756523988, 971.6987733802544, 989.8911119776819, 991.053543865621, 5945.346011938684, 5990.131430942489, 5991.131285963598, 6102.572819902653, 6240.625562466266, 419.45051981903805, 421.89030851978094, 427.11587014879524, 1000.4547521600745, 1004.6433516101824, 3851.768893866377, 3914.2758589661003, 3995.0, 4018.1561872007205, 4299.785010749512, 11412.0, 11521.53913843437, 11531.308121512737, 11654.592089276835, 11683.299002059734, 11571.710707232218, 11573.132015098901, 11581.247218930743, 11582.073434125417, 11587.478563464665, 8057.153998830156, 8344.08215096339, 8433.03020152678, 8637.093105223861, 8640.049594544595, 5993.730282137227, 6123.84690382744, 6187.535934804818, 6296.905546416899, 6382.648954307372, 10213.182945364502, 10439.895601044196, 10577.100946419332, 10581.841272381074, 10661.147108231478, 10773.784524309627, 10811.189160812813, 10873.238873278795, 10915.454227288763, 10926.672199834018, 7349.30181632744, 7894.21057894206, 8017.478863873829, 8037.557934313435, 8431.32549396059, 8891.066438023914, 8971.237444817263, 8974.820503590023, 8977.640894364153, 9035.774105647411, 7807.453478256468, 7849.568273744999, 7978.401619878417, 8224.506529608243, 8237.258646721824, 7903.525788452481, 8218.671253150047, 8290.0, 8291.626876790438, 8463.069062403254, 7044.15470143586, 7231.132264128339, 7272.163701174432, 7283.708651653875, 7307.269273072863, 5229.398619158694, 5312.468753124656, 5316.787328506816, 5346.518813306821, 5360.115580929103, 5181.119209734279, 5313.920291195558, 5331.546818520469, 5342.332208473941, 5347.759350829144], "value": 4705.958124249107, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.88642315919935, 315.47001038255735, 316.2189392201265, 321.82943040188695, 330.214090464694, 5084.542391184793, 5177.715225662587, 5294.788208471661, 5314.990151871142, 5339.412664606895, 5173.9482605173935, 5202.621305354084, 5203.583713302936, 5231.843044708665, 5259.579913423383, 4076.1440097579543, 4081.673466122718, 4098.918021639565, 4111.075008123178, 4115.897102572445, 3940.330143875548, 3962.8216730247063, 4137.8758637240935, 4160.188763191179, 4192.664586833046, 4099.979500102495, 4122.0, 4146.44023056888, 4151.730137541065, 4169.958300417003, 4143.958560414402, 4170.207660544517, 4171.958280417202, 4179.623833854967, 4191.601797829232, 3490.4764285357146, 3720.9813950930343, 3724.1620635356826, 3728.8694895678523, 3736.0846592584717, 5161.225816127611, 5166.328377310963, 5174.663646862942, 5191.506806853343, 5193.272941788153, 4789.233722604401, 4793.137235297645, 4798.736069516175, 4802.231642937113, 4813.109574728652, 5388.407275199725, 5471.534919531845, 5576.721163941827, 5581.8604534886545, 5590.350846500292, 3991.560928297914, 4016.518017837849, 4023.75857448554, 4044.211378781139, 4055.1484188320487, 5638.267025286727, 5701.230333904911, 5701.458361455655, 5704.8859022819315, 5733.655980641175, 3917.373220284741, 4082.7346222495444, 4088.1823635273063, 4089.711740801638, 4093.529244136903, 4062.878113656595, 4090.4886889138857, 4103.958960410418, 4124.154548317588, 4125.1749650070105, 4633.2818413146015, 4637.350770892078, 4640.280756482751, 4684.203685373494, 4685.273782563708, 5406.351237851483, 5488.615796894179, 5492.423295553989, 5541.891621675681, 5577.2191893135, 1423.395057100728, 1423.6725553122633, 1431.7709166533305, 1435.9230577067199, 1444.714204358122, 924.357571487823, 935.5135329628691, 940.2149205413419, 957.7940742740344, 963.2631037256505, 4671.906561868744, 4752.42970843501, 4753.786079626425, 4774.641901857374, 4809.615230781599, 5052.459000005034, 5054.949450505522, 5058.342415485963, 5058.392992840809, 5068.26313790549, 4705.388299521041, 4740.288956656529, 4747.311639812208, 4795.592374648194, 4881.389826271716, 2976.7916245863016, 3015.54766784984, 3019.022540236149, 3021.425929073469, 3039.978414354474, 5761.452661997104, 5844.824655260349, 5848.853778655568, 5863.970680146572, 5897.7935772247765, 5590.748416321276, 5807.216025836458, 5815.680137592389, 5844.211031510777, 5857.58996870215, 5737.483626473638, 5775.509081728016, 5862.560307976833, 5865.442782935615, 5896.55293053378, 5326.786928522971, 5500.559955203654, 5614.185943038318, 5627.493525582717, 5671.489565939085, 5597.80407685729, 5610.13042978339, 5639.477341117958, 5640.71796410186, 5641.8589535261945, 5834.679092649945, 5835.241418615723, 5852.824415267549, 5855.180274761452, 5889.617174883619, 3587.605363410075, 3747.4566187902055, 3954.1696243789124, 3955.525336959468, 3960.386140148282, 5580.274564306615, 5586.525145362527, 5593.748281327432, 5616.326040875121, 5630.127330263816, 5494.423085575957, 5499.1476321170285, 5602.635828671123, 5641.464060914206, 5665.830025099253, 5360.544353729977, 5523.100372304572, 5546.278983732089, 5554.805581804618, 5597.692126933058, 5399.622026458111, 5416.350037995308, 5426.945730542802, 5431.103867861917, 5470.124780035176, 5464.398916119144, 5570.303712035996, 5593.468620481211, 5620.4660557247, 5631.436856314336, 5395.111710901153, 5395.946040539544, 5396.703181325065, 5474.343078830566, 5477.20580515815], "value": 4177.880638389794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.451358251685, 749.1534565940486, 757.6666266842589, 819.7622689420065, 839.0749372179764, 14717.705645887088, 15955.282012309444, 16021.839781602195, 16083.678326433494, 16132.354705811782, 13329.200247985103, 14665.780013299809, 14710.63223419415, 14809.703805923875, 14810.55568332949, 665.0622622102836, 776.5379599138532, 788.9092754333268, 809.1544336168718, 815.0708192660372, 808.2119933065273, 813.259933460551, 813.8453693798159, 825.7564018614523, 826.6486743134174, 858.0989960541438, 859.5487369131193, 864.3992425264444, 869.3783944479695, 871.8866547348867, 703.444279019574, 827.9461834980767, 860.711661593367, 866.4021824940802, 867.2541614211773, 616.9660668663222, 620.7299824576323, 620.7734177025399, 625.1341891480287, 626.3485974586424, 15214.923925380413, 15380.230988450645, 15420.306086226146, 15468.303926323342, 15470.613234669223, 14300.0, 14666.779998300033, 14687.412503499847, 14693.0, 14754.114753114847, 13305.268210248432, 13450.798238026437, 13488.12327198729, 13602.251876146807, 13795.310234488335, 4494.8202071917085, 4529.139463501924, 4576.977115114437, 4630.467496237909, 4662.6269898408045, 71169.6441517789, 71934.64032679908, 72803.63598182028, 72942.0, 73019.0, 11315.886841131647, 11502.137339699557, 11554.942225288987, 11564.76870462586, 11593.594224202281, 20266.088026038862, 20282.79717202809, 20321.085551150234, 20326.085326160064, 20820.0, 9036.548172591476, 9271.860922086174, 9332.906670933204, 9402.15380615748, 9430.575624096931, 4825.276208568673, 4895.6083513318845, 4965.875853103629, 4981.850544483671, 5176.197689358156, 3685.1708365617524, 3808.9809550952623, 3815.4086116651965, 3815.618438156162, 3816.866409675648, 550.1472717288187, 645.2160624840841, 656.6290046123925, 664.4485077385758, 676.972921083161, 739.245969111514, 748.3003391828657, 755.4560716284267, 755.9017327747358, 797.2704974947858, 9775.853362199572, 9991.550380232908, 10214.438205898598, 10272.640457584099, 10402.635907743193, 646.9385408386196, 716.1907045039072, 740.8925705772633, 753.4800987318732, 768.9158286815675, 4767.976160119247, 5035.0, 5057.468965758616, 5062.341895553628, 5071.5689166420525, 88140.55929720438, 89986.55006724925, 90959.5452022749, 108431.0, 129156.35421822831, 92598.53700731453, 93081.0, 93120.53439732757, 94464.52767736117, 95514.52242738742, 83386.0, 83814.0, 85556.57221713851, 86047.13952860517, 89340.5532972331, 9718.805623887623, 9817.067378599022, 9872.605095796087, 9928.950355248178, 9943.602255909682, 49136.262956054976, 49322.75338623284, 49723.75138124286, 50440.49559504358, 50896.655851135096, 45405.54594454145, 47750.76124619355, 71790.0, 72600.0, 73260.63369683118, 12342.321172335249, 12691.93654031724, 12713.173643713499, 12937.805932911202, 13394.0, 14681.779773303195, 14853.48012819546, 15660.0, 15773.211339432753, 15945.0, 13873.930630347188, 13929.164250145024, 14338.56984290473, 14402.20787856678, 14412.13527188372, 14693.632659183606, 14718.0, 14722.116672999655, 15242.618934526725, 15274.770878437055, 13345.933270333586, 13891.72216555643, 14040.648983775487, 14048.297585120907, 14534.56804268023, 11169.944150279196, 11237.887621123684, 11636.476358563716, 11639.359835209145, 11878.287302761863, 11100.61147859821, 11349.659510214708, 11490.88509114898, 11580.884191158317, 11930.284182949052], "value": 7670.811125235089, "unit": "score"}], "name": "dromaeo_css", "value": 7250.051931024443, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 127.0, 179.0, 126.0, 127.0, 157.0, 126.0, 159.0, 138.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 159.0, 161.0, 160.0, 164.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 126.0, 75.0, 75.0, 74.0, 74.0, 100.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 124.0, 85.0, 85.0, 85.0, 121.0, 84.0, 85.0, 125.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 154.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 84.0, 78.0, 79.0, 80.0, 87.0, 80.0, 92.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 122.0, 134.0, 120.0, 126.0, 120.0, 126.0, 120.0, 132.0, 124.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 162.0, 160.0, 159.0, 160.0, 158.0, 163.0, 159.0, 158.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 61.0, 62.0, 63.0, 61.0, 62.0, 62.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1495.9999999999998, "alertThreshold": 2.0}]} 19:43:24 INFO - Return code: 0 19:43:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:43:24 INFO - # TBPL SUCCESS # 19:43:24 INFO - Running post-action listener: _resource_record_post_action 19:43:24 INFO - ##### 19:43:24 INFO - ##### Finished run-tests step (success) 19:43:24 INFO - ##### 19:43:24 INFO - Running post-run listener: _resource_record_post_run 19:43:24 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 528592896; Read time: 0; Write time: 998668 19:43:24 INFO - TinderboxPrint: CPU usage
13.2% 19:43:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:43:24 INFO - TinderboxPrint: I/O write bytes / time
528,592,896 / 998,668 19:43:24 INFO - TinderboxPrint: CPU idle
8,279.7 (86.7%) 19:43:24 INFO - TinderboxPrint: CPU user
1,209.8 (12.7%) 19:43:24 INFO - TinderboxPrint: Swap in / out
0 / 0 19:43:24 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 226652160; Read time: 0; Write time: 578540 19:43:24 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 295649280; Read time: 0; Write time: 414552 19:43:25 INFO - Running post-run listener: _upload_blobber_files 19:43:25 INFO - Blob upload gear active. 19:43:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:43:25 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 19:43:25 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'] 19:43:25 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 19:43:25 INFO - (blobuploader) - INFO - Open directory for files ... 19:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:29 INFO - (blobuploader) - INFO - Done attempting. 19:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:30 INFO - (blobuploader) - INFO - Done attempting. 19:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:31 INFO - (blobuploader) - INFO - Done attempting. 19:43:31 INFO - (blobuploader) - INFO - Iteration through files over. 19:43:31 INFO - Return code: 0 19:43:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:43:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:43:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05062bcbf1ae25ed152b7cd4d7c146e093d72ea4628bd3a48de36bcdbd86ea753f1d747a1ae320449aec5b9524c05e09a34bf92d598fe7ce1ab8d5d211bca7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71b5d7b8b6a29939995ff93b413700de732b9064db42fd9a3114489cc7240058ed8f95de12d4485a1d1bcb6b3c2d753e8c48c20c606a2d67c08f57c9da7f0ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7178d5e51f679b04fba2b09521a80dcf52474aa0658a9ff72dce74352b2108aa7276b742aeba57e9d1b02f926f8f03c4ee93c22e161cd7b6cd862ebcae2d967d"} 19:43:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:43:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:43:31 INFO - Contents: 19:43:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05062bcbf1ae25ed152b7cd4d7c146e093d72ea4628bd3a48de36bcdbd86ea753f1d747a1ae320449aec5b9524c05e09a34bf92d598fe7ce1ab8d5d211bca7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71b5d7b8b6a29939995ff93b413700de732b9064db42fd9a3114489cc7240058ed8f95de12d4485a1d1bcb6b3c2d753e8c48c20c606a2d67c08f57c9da7f0ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7178d5e51f679b04fba2b09521a80dcf52474aa0658a9ff72dce74352b2108aa7276b742aeba57e9d1b02f926f8f03c4ee93c22e161cd7b6cd862ebcae2d967d"} 19:43:31 INFO - Running post-run listener: copy_logs_to_upload_dir 19:43:31 INFO - Copying logs to upload dir... 19:43:31 INFO - mkdir: /builds/slave/test/build/upload/logs 19:43:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.354232 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-22 19:43:31.116590) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:31.120548) ========= 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=af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05062bcbf1ae25ed152b7cd4d7c146e093d72ea4628bd3a48de36bcdbd86ea753f1d747a1ae320449aec5b9524c05e09a34bf92d598fe7ce1ab8d5d211bca7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71b5d7b8b6a29939995ff93b413700de732b9064db42fd9a3114489cc7240058ed8f95de12d4485a1d1bcb6b3c2d753e8c48c20c606a2d67c08f57c9da7f0ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7178d5e51f679b04fba2b09521a80dcf52474aa0658a9ff72dce74352b2108aa7276b742aeba57e9d1b02f926f8f03c4ee93c22e161cd7b6cd862ebcae2d967d"} build_url:https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05062bcbf1ae25ed152b7cd4d7c146e093d72ea4628bd3a48de36bcdbd86ea753f1d747a1ae320449aec5b9524c05e09a34bf92d598fe7ce1ab8d5d211bca7f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71b5d7b8b6a29939995ff93b413700de732b9064db42fd9a3114489cc7240058ed8f95de12d4485a1d1bcb6b3c2d753e8c48c20c606a2d67c08f57c9da7f0ad9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7178d5e51f679b04fba2b09521a80dcf52474aa0658a9ff72dce74352b2108aa7276b742aeba57e9d1b02f926f8f03c4ee93c22e161cd7b6cd862ebcae2d967d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:31.147165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:31.147549) ========= 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=af724c981e2a0f424dbabf99000001e7-1466647478.578854-894462440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:31.229409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 19:43:31.229834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 19:43:31.230191) ========= ========= Total master_lag: 0.17 =========