builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1465311903.04 results: success (0) buildid: 20160607052829 builduid: d62f8d62e62d4c43b623683831625537 revision: 17c1f2315eb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.036177) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.036671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.036954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.049103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.049487) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 08:05:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-07 08:05:04 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077945 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.143239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.143772) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014765 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:03.194727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 08:05:03.195120) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 17c1f2315eb5 --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 17c1f2315eb5 --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=d6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 08:05:04,436 Setting DEBUG logging. 2016-06-07 08:05:04,437 attempt 1/10 2016-06-07 08:05:04,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/17c1f2315eb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 08:05:05,688 unpacking tar archive at: mozilla-inbound-17c1f2315eb5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.594091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 08:05:04.804121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:04.804456) ========= script_repo_revision: 17c1f2315eb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:04.804863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:04.805131) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 08:05:04.814355) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-07 08:05:04.814636) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:05:06 INFO - MultiFileLogger online at 20160607 08:05:06 in /builds/slave/test 08:05:06 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 08:05:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:05:06 INFO - {'append_to_log': False, 08:05:06 INFO - 'base_work_dir': '/builds/slave/test', 08:05:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:05:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:05:06 INFO - 'branch': 'Mozilla-Inbound', 08:05:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:05:06 INFO - 'config_files': ('talos/linux_config.py',), 08:05:06 INFO - 'default_actions': ('clobber', 08:05:06 INFO - 'read-buildbot-config', 08:05:06 INFO - 'download-and-extract', 08:05:06 INFO - 'populate-webroot', 08:05:06 INFO - 'create-virtualenv', 08:05:06 INFO - 'install', 08:05:06 INFO - 'run-tests'), 08:05:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:05:06 INFO - 'download_minidump_stackwalk': True, 08:05:06 INFO - 'download_symbols': 'ondemand', 08:05:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:05:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:05:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:05:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:05:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:05:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:05:06 INFO - 'installer_path': 'installer.exe', 08:05:06 INFO - 'log_level': 'info', 08:05:06 INFO - 'log_name': 'talos', 08:05:06 INFO - 'log_to_console': True, 08:05:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:05:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:05:06 INFO - 'opt_config_files': (), 08:05:06 INFO - 'pip_index': False, 08:05:06 INFO - 'sps_profile': False, 08:05:06 INFO - 'sps_profile_interval': 0, 08:05:06 INFO - 'suite': 'dromaeojs', 08:05:06 INFO - 'system_bits': '32', 08:05:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:05:06 INFO - 'title': 'talos-linux64-ix-034', 08:05:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:05:06 INFO - 'use_talos_json': True, 08:05:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:05:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:05:06 INFO - 'work_dir': 'build'} 08:05:06 INFO - ##### 08:05:06 INFO - ##### Running clobber step. 08:05:06 INFO - ##### 08:05:06 INFO - Running pre-action listener: _resource_record_pre_action 08:05:06 INFO - Running main action method: clobber 08:05:06 INFO - rmtree: /builds/slave/test/build 08:05:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:05:06 INFO - Running post-action listener: _resource_record_post_action 08:05:06 INFO - ##### 08:05:06 INFO - ##### Finished clobber step (success) 08:05:06 INFO - ##### 08:05:06 INFO - ##### 08:05:06 INFO - ##### Running read-buildbot-config step. 08:05:06 INFO - ##### 08:05:06 INFO - Running pre-action listener: _resource_record_pre_action 08:05:06 INFO - Running main action method: read_buildbot_config 08:05:06 INFO - Using buildbot properties: 08:05:06 INFO - { 08:05:06 INFO - "project": "", 08:05:06 INFO - "product": "firefox", 08:05:06 INFO - "script_repo_revision": "production", 08:05:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:05:06 INFO - "repository": "", 08:05:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 08:05:06 INFO - "buildid": "20160607052829", 08:05:06 INFO - "pgo_build": "True", 08:05:06 INFO - "basedir": "/builds/slave/test", 08:05:06 INFO - "buildnumber": 1142, 08:05:06 INFO - "slavename": "talos-linux64-ix-034", 08:05:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:05:06 INFO - "platform": "ubuntu64_hw", 08:05:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 08:05:06 INFO - "branch": "mozilla-inbound", 08:05:06 INFO - "repo_path": "integration/mozilla-inbound", 08:05:06 INFO - "revision": "17c1f2315eb5", 08:05:06 INFO - "stage_platform": "linux64-pgo", 08:05:06 INFO - "builduid": "d62f8d62e62d4c43b623683831625537", 08:05:06 INFO - "slavebuilddir": "test" 08:05:06 INFO - } 08:05:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:05:06 INFO - Running post-action listener: _resource_record_post_action 08:05:06 INFO - ##### 08:05:06 INFO - ##### Finished read-buildbot-config step (success) 08:05:06 INFO - ##### 08:05:06 INFO - ##### 08:05:06 INFO - ##### Running download-and-extract step. 08:05:06 INFO - ##### 08:05:06 INFO - Running pre-action listener: _resource_record_pre_action 08:05:06 INFO - Running main action method: download_and_extract 08:05:06 INFO - mkdir: /builds/slave/test/build/tests 08:05: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')]} 08:05:06 INFO - https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:05:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:07 INFO - Downloaded 1361 bytes. 08:05:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:05:07 INFO - Using the following test package requirements: 08:05:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:05:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:05:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'jsshell-linux-x86_64.zip'], 08:05:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:05:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:05:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:05:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:05:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:05:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:05:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:05:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:07 INFO - https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:08 INFO - Downloaded 24440726 bytes. 08:05:08 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'] 08:05:08 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 08:05:10 INFO - Return code: 0 08:05:10 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 08:05:10 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')]} 08:05:10 INFO - https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:11 INFO - Downloaded 24440726 bytes. 08:05:11 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'] 08:05:11 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 08:05:12 INFO - Return code: 0 08:05:12 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')]} 08:05:12 INFO - https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:14 INFO - Downloaded 10833369 bytes. 08:05:14 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'] 08:05:14 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 08:05:15 INFO - Return code: 0 08:05:15 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')]} 08:05:15 INFO - https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTowXjKsSnuxD_35ykwEQg/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 08:05:16 INFO - Downloaded 59207058 bytes. 08:05:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:16 INFO - mkdir: /builds/slave/test/properties 08:05:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:16 INFO - Contents: 08:05:16 INFO - build_url:https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:05:17 INFO - Running post-action listener: _resource_record_post_action 08:05:17 INFO - Running post-action listener: set_extra_try_arguments 08:05:17 INFO - ##### 08:05:17 INFO - ##### Finished download-and-extract step (success) 08:05:17 INFO - ##### 08:05:17 INFO - ##### 08:05:17 INFO - ##### Running populate-webroot step. 08:05:17 INFO - ##### 08:05:17 INFO - Running pre-action listener: _resource_record_pre_action 08:05:17 INFO - Running main action method: populate_webroot 08:05:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:17 INFO - '--tppagecycles', 08:05:17 INFO - '7'], 08:05:17 INFO - 'tests': ['tsvgm']}}, 08:05:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['damp', 'tps']}, 08:05:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'tests': ['damp', 'tps']}, 08:05:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['dromaeo_dom']}, 08:05:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['a11yr', 08:05:17 INFO - 'ts_paint', 08:05:17 INFO - 'tpaint', 08:05:17 INFO - 'sessionrestore', 08:05:17 INFO - 'sessionrestore_no_auto_restore', 08:05:17 INFO - 'tabpaint']}, 08:05:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:17 INFO - 'ts_paint', 08:05:17 INFO - 'tpaint', 08:05:17 INFO - 'sessionrestore', 08:05:17 INFO - 'sessionrestore_no_auto_restore', 08:05:17 INFO - 'tabpaint']}, 08:05:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:17 INFO - 'ts_paint', 08:05:17 INFO - 'tpaint', 08:05:17 INFO - 'sessionrestore', 08:05:17 INFO - 'sessionrestore_no_auto_restore', 08:05:17 INFO - 'tabpaint']}, 08:05:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:17 INFO - 'ts_paint', 08:05:17 INFO - 'tpaint', 08:05:17 INFO - 'sessionrestore', 08:05:17 INFO - 'sessionrestore_no_auto_restore', 08:05:17 INFO - 'tabpaint']}, 08:05:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['a11yr', 08:05:17 INFO - 'ts_paint', 08:05:17 INFO - 'tpaint', 08:05:17 INFO - 'sessionrestore', 08:05:17 INFO - 'sessionrestore_no_auto_restore', 08:05:17 INFO - 'tabpaint']}, 08:05:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['a11yr', 08:05:17 INFO - 'ts_paint', 08:05:17 INFO - 'tpaint', 08:05:17 INFO - 'sessionrestore', 08:05:17 INFO - 'sessionrestore_no_auto_restore', 08:05:17 INFO - 'tabpaint']}, 08:05:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['tsvgx', 08:05:17 INFO - 'tsvgr_opacity', 08:05:17 INFO - 'tart', 08:05:17 INFO - 'tscrollx', 08:05:17 INFO - 'cart']}, 08:05:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:17 INFO - 'tsvgr_opacity', 08:05:17 INFO - 'tart', 08:05:17 INFO - 'tscrollx', 08:05:17 INFO - 'cart']}, 08:05:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'talos_options': ['--disable-e10s'], 08:05:17 INFO - 'tests': ['tp5o']}, 08:05:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'tests': ['tp5o']}, 08:05:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'talos_options': ['--disable-e10s', 08:05:17 INFO - '--xperf_path', 08:05:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:17 INFO - 'tests': ['tp5n']}, 08:05:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:17 INFO - 'talos_options': ['--xperf_path', 08:05:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:17 INFO - 'tests': ['tp5n']}}, 08:05:17 INFO - 'talos.zip': {'path': '', 08:05:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:17 INFO - Running post-action listener: _resource_record_post_action 08:05:17 INFO - ##### 08:05:17 INFO - ##### Finished populate-webroot step (success) 08:05:17 INFO - ##### 08:05:17 INFO - ##### 08:05:17 INFO - ##### Running create-virtualenv step. 08:05:17 INFO - ##### 08:05:17 INFO - Running pre-action listener: _resource_record_pre_action 08:05:17 INFO - Running main action method: create_virtualenv 08:05:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:17 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 08:05:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:17 INFO - Using real prefix '/usr' 08:05:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:20 INFO - Installing pip.................done. 08:05:20 INFO - Return code: 0 08:05:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:05:20 INFO - Using env: {'DISPLAY': ':0', 08:05:20 INFO - 'HOME': '/home/cltbld', 08:05:20 INFO - 'LANG': 'en_US.UTF-8', 08:05:20 INFO - 'LANGUAGE': 'en_US:en', 08:05:20 INFO - 'LOGNAME': 'cltbld', 08:05:20 INFO - 'MAIL': '/var/mail/cltbld', 08:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:20 INFO - 'MOZ_NO_REMOTE': '1', 08:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:20 INFO - 'NO_EM_RESTART': '1', 08:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:20 INFO - 'PWD': '/builds/slave/test', 08:05:20 INFO - 'SHELL': '/bin/bash', 08:05:20 INFO - 'SHLVL': '1', 08:05:20 INFO - 'TERM': 'linux', 08:05:20 INFO - 'TMOUT': '86400', 08:05:20 INFO - 'USER': 'cltbld', 08:05:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:20 INFO - '_': '/tools/buildbot/bin/python'} 08:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:20 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 08:05:20 INFO - Cleaning up... 08:05:20 INFO - Return code: 0 08:05:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:05:20 INFO - Using env: {'DISPLAY': ':0', 08:05:20 INFO - 'HOME': '/home/cltbld', 08:05:20 INFO - 'LANG': 'en_US.UTF-8', 08:05:20 INFO - 'LANGUAGE': 'en_US:en', 08:05:20 INFO - 'LOGNAME': 'cltbld', 08:05:20 INFO - 'MAIL': '/var/mail/cltbld', 08:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:20 INFO - 'MOZ_NO_REMOTE': '1', 08:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:20 INFO - 'NO_EM_RESTART': '1', 08:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:20 INFO - 'PWD': '/builds/slave/test', 08:05:20 INFO - 'SHELL': '/bin/bash', 08:05:20 INFO - 'SHLVL': '1', 08:05:20 INFO - 'TERM': 'linux', 08:05:20 INFO - 'TMOUT': '86400', 08:05:20 INFO - 'USER': 'cltbld', 08:05:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:20 INFO - '_': '/tools/buildbot/bin/python'} 08:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:20 INFO - Downloading/unpacking psutil>=3.1.1 08:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:22 INFO - Installing collected packages: psutil 08:05:22 INFO - Running setup.py install for psutil 08:05:22 INFO - building 'psutil._psutil_linux' extension 08:05:22 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 08:05:22 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 08:05:22 INFO - building 'psutil._psutil_posix' extension 08:05:22 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 08:05:22 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 08:05:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:22 INFO - Successfully installed psutil 08:05:22 INFO - Cleaning up... 08:05:23 INFO - Return code: 0 08:05:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:23 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')]} 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:23 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')]} 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:23 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:23 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 08:05:23 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 08:05:23 INFO - Using env: {'DISPLAY': ':0', 08:05:23 INFO - 'HOME': '/home/cltbld', 08:05:23 INFO - 'LANG': 'en_US.UTF-8', 08:05:23 INFO - 'LANGUAGE': 'en_US:en', 08:05:23 INFO - 'LOGNAME': 'cltbld', 08:05:23 INFO - 'MAIL': '/var/mail/cltbld', 08:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:23 INFO - 'MOZ_NO_REMOTE': '1', 08:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:23 INFO - 'NO_EM_RESTART': '1', 08:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:23 INFO - 'PWD': '/builds/slave/test', 08:05:23 INFO - 'SHELL': '/bin/bash', 08:05:23 INFO - 'SHLVL': '1', 08:05:23 INFO - 'TERM': 'linux', 08:05:23 INFO - 'TMOUT': '86400', 08:05:23 INFO - 'USER': 'cltbld', 08:05:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:23 INFO - '_': '/tools/buildbot/bin/python'} 08:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:25 INFO - Installing collected packages: mozsystemmonitor 08:05:25 INFO - Running setup.py install for mozsystemmonitor 08:05:25 INFO - Successfully installed mozsystemmonitor 08:05:25 INFO - Cleaning up... 08:05:25 INFO - Return code: 0 08:05:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:25 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')]} 08:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:25 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')]} 08:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:25 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:25 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 08:05:25 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 08:05:25 INFO - Using env: {'DISPLAY': ':0', 08:05:25 INFO - 'HOME': '/home/cltbld', 08:05:25 INFO - 'LANG': 'en_US.UTF-8', 08:05:25 INFO - 'LANGUAGE': 'en_US:en', 08:05:25 INFO - 'LOGNAME': 'cltbld', 08:05:25 INFO - 'MAIL': '/var/mail/cltbld', 08:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:25 INFO - 'MOZ_NO_REMOTE': '1', 08:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:25 INFO - 'NO_EM_RESTART': '1', 08:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:25 INFO - 'PWD': '/builds/slave/test', 08:05:25 INFO - 'SHELL': '/bin/bash', 08:05:25 INFO - 'SHLVL': '1', 08:05:25 INFO - 'TERM': 'linux', 08:05:25 INFO - 'TMOUT': '86400', 08:05:25 INFO - 'USER': 'cltbld', 08:05:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:25 INFO - '_': '/tools/buildbot/bin/python'} 08:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05: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 08:05:27 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:27 INFO - warning: no files found matching '*.txt' 08:05:27 INFO - no previously-included directories found matching 'build' 08:05:27 INFO - no previously-included directories found matching 'dist' 08:05:27 INFO - no previously-included directories found matching '.git*' 08:05:27 INFO - Installing collected packages: jsonschema, functools32 08:05:27 INFO - Running setup.py install for functools32 08:05:27 INFO - warning: no files found matching '*.txt' 08:05:27 INFO - no previously-included directories found matching 'build' 08:05:27 INFO - no previously-included directories found matching 'dist' 08:05:27 INFO - no previously-included directories found matching '.git*' 08:05:27 INFO - Successfully installed jsonschema functools32 08:05:27 INFO - Cleaning up... 08:05:27 INFO - Return code: 0 08:05:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:27 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')]} 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:27 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')]} 08:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:27 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:27 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 08:05:27 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 08:05:27 INFO - Using env: {'DISPLAY': ':0', 08:05:27 INFO - 'HOME': '/home/cltbld', 08:05:27 INFO - 'LANG': 'en_US.UTF-8', 08:05:27 INFO - 'LANGUAGE': 'en_US:en', 08:05:27 INFO - 'LOGNAME': 'cltbld', 08:05:27 INFO - 'MAIL': '/var/mail/cltbld', 08:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:27 INFO - 'MOZ_NO_REMOTE': '1', 08:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:27 INFO - 'NO_EM_RESTART': '1', 08:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:27 INFO - 'PWD': '/builds/slave/test', 08:05:27 INFO - 'SHELL': '/bin/bash', 08:05:27 INFO - 'SHLVL': '1', 08:05:27 INFO - 'TERM': 'linux', 08:05:27 INFO - 'TMOUT': '86400', 08:05:27 INFO - 'USER': 'cltbld', 08:05:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:27 INFO - '_': '/tools/buildbot/bin/python'} 08:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:28 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 08:05:28 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 08:05:28 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 08:05:28 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 08:05:28 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 08:05:28 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 08:05:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 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 08:05:30 INFO - Downloading docopt-0.6.1.tar.gz 08:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:30 INFO - Running setup.py install for blobuploader 08:05:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:30 INFO - Running setup.py install for requests 08:05:31 INFO - Running setup.py install for docopt 08:05:31 INFO - Successfully installed blobuploader requests docopt 08:05:31 INFO - Cleaning up... 08:05:31 INFO - Return code: 0 08:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:31 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')]} 08:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:31 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')]} 08:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:31 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:31 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 08:05:31 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 08:05:31 INFO - Using env: {'DISPLAY': ':0', 08:05:31 INFO - 'HOME': '/home/cltbld', 08:05:31 INFO - 'LANG': 'en_US.UTF-8', 08:05:31 INFO - 'LANGUAGE': 'en_US:en', 08:05:31 INFO - 'LOGNAME': 'cltbld', 08:05:31 INFO - 'MAIL': '/var/mail/cltbld', 08:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:31 INFO - 'MOZ_NO_REMOTE': '1', 08:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:31 INFO - 'NO_EM_RESTART': '1', 08:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:31 INFO - 'PWD': '/builds/slave/test', 08:05:31 INFO - 'SHELL': '/bin/bash', 08:05:31 INFO - 'SHLVL': '1', 08:05:31 INFO - 'TERM': 'linux', 08:05:31 INFO - 'TMOUT': '86400', 08:05:31 INFO - 'USER': 'cltbld', 08:05:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:31 INFO - '_': '/tools/buildbot/bin/python'} 08:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:31 INFO - Running setup.py (path:/tmp/pip-a26U42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:31 INFO - Running setup.py (path:/tmp/pip-nxi3BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:31 INFO - Running setup.py (path:/tmp/pip-3XlndZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:31 INFO - Running setup.py (path:/tmp/pip-NMxYsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:31 INFO - Running setup.py (path:/tmp/pip-0aYIJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:32 INFO - Running setup.py (path:/tmp/pip-qhGfW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:32 INFO - Running setup.py (path:/tmp/pip-LAbAAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:32 INFO - Running setup.py (path:/tmp/pip-lJI4AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:32 INFO - Running setup.py (path:/tmp/pip-8E9qs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:32 INFO - Running setup.py (path:/tmp/pip-mgNWZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:32 INFO - Running setup.py (path:/tmp/pip-OSqO0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:32 INFO - Running setup.py (path:/tmp/pip-0IGE16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:32 INFO - Running setup.py (path:/tmp/pip-v08_ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:32 INFO - Running setup.py (path:/tmp/pip-XNzpyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:32 INFO - Running setup.py (path:/tmp/pip-J6_Ol0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:32 INFO - Running setup.py (path:/tmp/pip-yNc0wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:32 INFO - Running setup.py (path:/tmp/pip-Mrgi5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:32 INFO - Running setup.py install for manifestparser 08:05:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozcrash 08:05:33 INFO - Running setup.py install for mozdebug 08:05:33 INFO - Running setup.py install for mozdevice 08:05:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozfile 08:05:33 INFO - Running setup.py install for mozhttpd 08:05:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozinfo 08:05:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozInstall 08:05:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for mozleak 08:05:33 INFO - Running setup.py install for mozlog 08:05:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:33 INFO - Running setup.py install for moznetwork 08:05:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozprocess 08:05:34 INFO - Running setup.py install for mozprofile 08:05:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozrunner 08:05:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Running setup.py install for mozscreenshot 08:05:34 INFO - Running setup.py install for moztest 08:05:34 INFO - Running setup.py install for mozversion 08:05:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:34 INFO - Cleaning up... 08:05:34 INFO - Return code: 0 08:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:34 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:34 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 08:05:34 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 08:05:34 INFO - Using env: {'DISPLAY': ':0', 08:05:34 INFO - 'HOME': '/home/cltbld', 08:05:34 INFO - 'LANG': 'en_US.UTF-8', 08:05:34 INFO - 'LANGUAGE': 'en_US:en', 08:05:34 INFO - 'LOGNAME': 'cltbld', 08:05:34 INFO - 'MAIL': '/var/mail/cltbld', 08:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:34 INFO - 'MOZ_NO_REMOTE': '1', 08:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:34 INFO - 'NO_EM_RESTART': '1', 08:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:34 INFO - 'PWD': '/builds/slave/test', 08:05:34 INFO - 'SHELL': '/bin/bash', 08:05:34 INFO - 'SHLVL': '1', 08:05:34 INFO - 'TERM': 'linux', 08:05:34 INFO - 'TMOUT': '86400', 08:05:34 INFO - 'USER': 'cltbld', 08:05:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:34 INFO - '_': '/tools/buildbot/bin/python'} 08:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:34 INFO - Running setup.py (path:/tmp/pip-jKvWLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:34 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)) 08:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:34 INFO - Running setup.py (path:/tmp/pip-YeLd5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:35 INFO - Running setup.py (path:/tmp/pip-8h8Cpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:35 INFO - Running setup.py (path:/tmp/pip-kOXnZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:35 INFO - Running setup.py (path:/tmp/pip-JjYWg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:35 INFO - Running setup.py (path:/tmp/pip-rdaPuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:35 INFO - Running setup.py (path:/tmp/pip-WwQN4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:35 INFO - Running setup.py (path:/tmp/pip-sSRkUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:35 INFO - Running setup.py (path:/tmp/pip-s0elYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:35 INFO - Running setup.py (path:/tmp/pip-ovf8iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:35 INFO - Running setup.py (path:/tmp/pip-LY345b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:35 INFO - Running setup.py (path:/tmp/pip-Twx6GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:35 INFO - Running setup.py (path:/tmp/pip-Zbbdjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:35 INFO - Running setup.py (path:/tmp/pip-kk6DB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:35 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)) 08:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:35 INFO - Running setup.py (path:/tmp/pip-lgyteI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:36 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)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:36 INFO - Running setup.py (path:/tmp/pip-_QZwYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:36 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)) 08:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:36 INFO - Running setup.py (path:/tmp/pip-UgOLol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:36 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)) 08:05:36 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)) 08:05:36 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)) 08:05:36 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)) 08:05:36 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)) 08:05:36 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)) 08:05:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:36 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 08:05:36 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 08:05:36 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 08:05:36 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 08:05:36 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 08:05:36 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 08:05:38 INFO - Downloading blessings-1.6.tar.gz 08:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:38 INFO - Installing collected packages: blessings 08:05:38 INFO - Running setup.py install for blessings 08:05:38 INFO - Successfully installed blessings 08:05:38 INFO - Cleaning up... 08:05:38 INFO - Return code: 0 08:05:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:38 INFO - Reading from file tmpfile_stdout 08:05:38 INFO - Current package versions: 08:05:38 INFO - argparse == 1.2.1 08:05:38 INFO - blessings == 1.6 08:05:38 INFO - blobuploader == 1.2.4 08:05:38 INFO - docopt == 0.6.1 08:05:38 INFO - functools32 == 3.2.3-2 08:05:38 INFO - jsonschema == 2.5.1 08:05:38 INFO - manifestparser == 1.1 08:05:38 INFO - mozInstall == 1.12 08:05:38 INFO - mozcrash == 0.17 08:05:38 INFO - mozdebug == 0.1 08:05:38 INFO - mozdevice == 0.48 08:05:38 INFO - mozfile == 1.2 08:05:38 INFO - mozhttpd == 0.7 08:05:38 INFO - mozinfo == 0.9 08:05:38 INFO - mozleak == 0.1 08:05:38 INFO - mozlog == 3.2 08:05:38 INFO - moznetwork == 0.27 08:05:38 INFO - mozprocess == 0.22 08:05:38 INFO - mozprofile == 0.28 08:05:38 INFO - mozrunner == 6.11 08:05:38 INFO - mozscreenshot == 0.1 08:05:38 INFO - mozsystemmonitor == 0.3 08:05:38 INFO - moztest == 0.7 08:05:38 INFO - mozversion == 1.4 08:05:38 INFO - psutil == 3.1.1 08:05:38 INFO - requests == 1.2.3 08:05:38 INFO - wsgiref == 0.1.2 08:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:38 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 08:05:38 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 08:05:38 INFO - Using env: {'DISPLAY': ':0', 08:05:38 INFO - 'HOME': '/home/cltbld', 08:05:38 INFO - 'LANG': 'en_US.UTF-8', 08:05:38 INFO - 'LANGUAGE': 'en_US:en', 08:05:38 INFO - 'LOGNAME': 'cltbld', 08:05:38 INFO - 'MAIL': '/var/mail/cltbld', 08:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:38 INFO - 'MOZ_NO_REMOTE': '1', 08:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:38 INFO - 'NO_EM_RESTART': '1', 08:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:38 INFO - 'PWD': '/builds/slave/test', 08:05:38 INFO - 'SHELL': '/bin/bash', 08:05:38 INFO - 'SHLVL': '1', 08:05:38 INFO - 'TERM': 'linux', 08:05:38 INFO - 'TMOUT': '86400', 08:05:38 INFO - 'USER': 'cltbld', 08:05:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:38 INFO - '_': '/tools/buildbot/bin/python'} 08:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 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)) 08:05:38 INFO - Cleaning up... 08:05:38 INFO - Return code: 0 08:05:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:38 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 08:05:38 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 08:05:38 INFO - Using env: {'DISPLAY': ':0', 08:05:38 INFO - 'HOME': '/home/cltbld', 08:05:38 INFO - 'LANG': 'en_US.UTF-8', 08:05:38 INFO - 'LANGUAGE': 'en_US:en', 08:05:38 INFO - 'LOGNAME': 'cltbld', 08:05:38 INFO - 'MAIL': '/var/mail/cltbld', 08:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:38 INFO - 'MOZ_NO_REMOTE': '1', 08:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:38 INFO - 'NO_EM_RESTART': '1', 08:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:38 INFO - 'PWD': '/builds/slave/test', 08:05:38 INFO - 'SHELL': '/bin/bash', 08:05:38 INFO - 'SHLVL': '1', 08:05:38 INFO - 'TERM': 'linux', 08:05:38 INFO - 'TMOUT': '86400', 08:05:38 INFO - 'USER': 'cltbld', 08:05:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:38 INFO - '_': '/tools/buildbot/bin/python'} 08:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:38 INFO - Cleaning up... 08:05:38 INFO - Return code: 0 08:05:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:38 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 0x7f0b95e2ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', '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 08:05:38 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 08:05:38 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 08:05:38 INFO - Using env: {'DISPLAY': ':0', 08:05:38 INFO - 'HOME': '/home/cltbld', 08:05:38 INFO - 'LANG': 'en_US.UTF-8', 08:05:38 INFO - 'LANGUAGE': 'en_US:en', 08:05:38 INFO - 'LOGNAME': 'cltbld', 08:05:38 INFO - 'MAIL': '/var/mail/cltbld', 08:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:38 INFO - 'MOZ_NO_REMOTE': '1', 08:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:38 INFO - 'NO_EM_RESTART': '1', 08:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:38 INFO - 'PWD': '/builds/slave/test', 08:05:38 INFO - 'SHELL': '/bin/bash', 08:05:38 INFO - 'SHLVL': '1', 08:05:38 INFO - 'TERM': 'linux', 08:05:38 INFO - 'TMOUT': '86400', 08:05:38 INFO - 'USER': 'cltbld', 08:05:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:38 INFO - '_': '/tools/buildbot/bin/python'} 08:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:39 INFO - Downloading/unpacking flake8 08:05:39 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 08:05:39 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 08:05:39 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 08:05:39 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 08:05:39 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 08:05:39 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 08:05:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:05:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:05:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 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 08:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:41 INFO - no previously-included directories found matching 'docs/_build' 08:05:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:05:41 INFO - Running setup.py install for pep8 08:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:41 INFO - no previously-included directories found matching 'docs/_build' 08:05:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:05:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:05:41 INFO - Cleaning up... 08:05:42 INFO - Return code: 0 08:05:42 INFO - Running post-action listener: _resource_record_post_action 08:05:42 INFO - Running post-action listener: _start_resource_monitoring 08:05:42 INFO - Starting resource monitoring. 08:05:42 INFO - ##### 08:05:42 INFO - ##### Finished create-virtualenv step (success) 08:05:42 INFO - ##### 08:05:42 INFO - ##### 08:05:42 INFO - ##### Running install step. 08:05:42 INFO - ##### 08:05:42 INFO - Running pre-action listener: _resource_record_pre_action 08:05:42 INFO - Running main action method: install 08:05:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:42 INFO - Reading from file tmpfile_stdout 08:05:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:42 INFO - Reading from file tmpfile_stdout 08:05:42 INFO - Output received: 08:05:42 INFO - Usage: mozinstall [options] installer 08:05:42 INFO - Options: 08:05:42 INFO - -h, --help show this help message and exit 08:05:42 INFO - -d DEST, --destination=DEST 08:05:42 INFO - Directory to install application into. [default: 08:05:42 INFO - "/builds/slave/test"] 08:05:42 INFO - --app=APP Application being installed. [default: firefox] 08:05:42 INFO - mkdir: /builds/slave/test/build/application 08:05:42 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'] 08:05:42 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 08:05:59 INFO - Reading from file tmpfile_stdout 08:05:59 INFO - Output received: 08:05:59 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:59 INFO - Running post-action listener: _resource_record_post_action 08:05:59 INFO - ##### 08:05:59 INFO - ##### Finished install step (success) 08:05:59 INFO - ##### 08:05:59 INFO - ##### 08:05:59 INFO - ##### Running run-tests step. 08:05:59 INFO - ##### 08:05:59 INFO - Running pre-action listener: _resource_record_pre_action 08:05:59 INFO - Running main action method: run_tests 08:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:59 INFO - Python 2.7.3 08:05:59 INFO - Return code: 0 08:05:59 INFO - grabbing minidump binary from tooltool 08:05: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')]} 08:05:59 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 0x13752e0>, '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 0x12e1140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e15d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:59 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 08:05:59 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 08:05:59 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 08:05:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:59 INFO - Return code: 0 08:05:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:06:00 INFO - Return code: 0 08:06:00 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/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:06:00 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/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 08:06:00 INFO - Using env: {'DISPLAY': ':0', 08:06:00 INFO - 'HOME': '/home/cltbld', 08:06:00 INFO - 'LANG': 'en_US.UTF-8', 08:06:00 INFO - 'LANGUAGE': 'en_US:en', 08:06:00 INFO - 'LOGNAME': 'cltbld', 08:06:00 INFO - 'MAIL': '/var/mail/cltbld', 08:06:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:06:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:00 INFO - 'MOZ_NO_REMOTE': '1', 08:06:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:00 INFO - 'NO_EM_RESTART': '1', 08:06:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:00 INFO - 'PWD': '/builds/slave/test', 08:06:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:06:00 INFO - 'SHELL': '/bin/bash', 08:06:00 INFO - 'SHLVL': '1', 08:06:00 INFO - 'TERM': 'linux', 08:06:00 INFO - 'TMOUT': '86400', 08:06:00 INFO - 'USER': 'cltbld', 08:06:00 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086', 08:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:00 INFO - '_': '/tools/buildbot/bin/python'} 08:06:00 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/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:06:00 INFO - mozversion application_buildid: 20160607052829 08:06:00 INFO - mozversion application_changeset: 17c1f2315eb528745cfc7b73b1f5dc6cfcf7a35c 08:06:00 INFO - mozversion application_display_name: Nightly 08:06:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:06:00 INFO - mozversion application_name: Firefox 08:06:00 INFO - mozversion application_remotingname: firefox 08:06:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:06:00 INFO - mozversion application_vendor: Mozilla 08:06:00 INFO - mozversion application_version: 50.0a1 08:06:00 INFO - mozversion platform_buildid: 20160607052829 08:06:00 INFO - mozversion platform_changeset: 17c1f2315eb528745cfc7b73b1f5dc6cfcf7a35c 08:06:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:06:00 INFO - mozversion platform_version: 50.0a1 08:06:00 INFO - using testdate: 1465311960 08:06:00 INFO - actual date: 1465311960 08:06:00 INFO - starting webserver on 'localhost:41262' 08:06:00 INFO - SUITE-START | Running 2 tests 08:06:00 INFO - TEST-START | dromaeo_css 08:06:00 INFO - operating with platform_type : linux_ 08:06:00 INFO - Initialising browser for dromaeo_css test... 08:06:00 INFO - TEST-INFO | started process 11583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8aS3wY/profile http://localhost:41262/getInfo.html) 08:06:04 INFO - PROCESS | 11583 | __metrics Screen width/height:1600/1200 08:06:04 INFO - PROCESS | 11583 | colorDepth:24 08:06:04 INFO - PROCESS | 11583 | Browser inner width/height: 1024/697 08:06:04 INFO - PROCESS | 11583 | __metrics 08:06:05 ERROR - PROCESS | 11583 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:06:05 INFO - PROCESS | 11583 | console.error: PushService: 08:06:05 INFO - PROCESS | 11583 | stateChangeProcessEnqueue: Error transitioning state 08:06:05 INFO - PROCESS | 11583 | UnknownError 08:06:06 INFO - TEST-INFO | 11583: exit 0 08:06:06 INFO - Browser initialized. 08:06:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:06:06 INFO - TEST-INFO | started process 11665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8aS3wY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:18 INFO - PROCESS | 11665 | RSS: Main: 156655616 08:06:18 INFO - PROCESS | 11665 | 08:07:08 INFO - PROCESS | 11665 | 1465312028994 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] 08:09:16 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:41262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41262/tests/dromaeo/cssquery-ext.html) 08:09:17 INFO - PROCESS | 11665 | RSS: Main: 241238016 08:09:17 INFO - PROCESS | 11665 | 08:12:20 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:41262/tests/dromaeo/cssquery-ext.html (next: http://localhost:41262/tests/dromaeo/cssquery-jquery.html) 08:12:20 INFO - PROCESS | 11665 | RSS: Main: 233291776 08:12:20 INFO - PROCESS | 11665 | 08:15:22 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:41262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41262/tests/dromaeo/cssquery-mootools.html) 08:15:23 INFO - PROCESS | 11665 | RSS: Main: 240496640 08:15:23 INFO - PROCESS | 11665 | 08:18:25 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:41262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41262/tests/dromaeo/cssquery-prototype.html) 08:18:25 INFO - PROCESS | 11665 | RSS: Main: 236580864 08:18:25 INFO - PROCESS | 11665 | 08:21:28 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:41262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41262/tests/dromaeo/cssquery-yui.html) 08:21:28 INFO - PROCESS | 11665 | RSS: Main: 219295744 08:21:28 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | Cycle 1(1): loaded http://localhost:41262/tests/dromaeo/cssquery-yui.html (next: http://localhost:41262/tests/dromaeo/cssquery-dojo.html) 08:24:31 INFO - PROCESS | 11665 | RSS: Main: 273256448 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | __start_tp_report 08:24:31 INFO - PROCESS | 11665 | _x_x_mozilla_page_load 08:24:31 INFO - PROCESS | 11665 | _x_x_mozilla_page_load_details 08:24:31 INFO - PROCESS | 11665 | |i|pagename|runs| 08:24:31 INFO - PROCESS | 11665 | |0;dojo.html;3134.420132275528;3136.1845920060787;3160.4627213373724;3163.3198862244612;3201.4397480440916;5100.566451851597;5195.68825870448;5212.035773381922;5302.045631786282;5314.335708036496;5281.445448227938;5281.788728450857;5318.202269659553;5321;5332.33345831771;4751.263554149113;4780.067886762083;4886.438059623136;4955.752212389384;4974.602031837462;4937.728424936627;4949;4952.529509696573;4959.876003099916;4972.776225069881;4691.62467002639;4797.088553174903;4842.2736589511505;4844.249141383091;4873.731944743037;4850.75746212688;4851.5391037851705;4858.02839432115;4864.951350486521;4898.5591296783105;4818.614510839125;4836.613070954315;4867.415910090812;4867.464578896319;4893.388326459192;5081.237814327844;5142.125838607409;5175.404828444739;5207.713575753332;5278.419373868871;5583;5740.971295143498;5757.539396848242;5757.9712101439645;5766.365699773021;5731.656100633933;5748.109043098327;5788.18965344852;5803.506701930341;5804.1293805929445;5147.459516750725;5239.607029472805;5259.5529380002745;5260.026895024394;5341.65279256847;5847.386024467455;5855.033919403336;5859.589828712034;5863.70681465925;5871.031279838864;5617.38208797032;5623.915641265385;5634.098544232903;5653.519450846724;5660.179274005246;5474.315710536183;5566.916496252559;5571.0807716727095;5603.551715862721;5636.830895073154;5594.24477695514;5602.607817452821;5610.775568977277;5614.045612245928;5619.129034999582;5397.676139431646;5580.19087232349;5583.553315734732;5586.748596313176;5588.9720551397795;4339.262325404688;4372.715773474714;4375.365571992107;4392.231359512072;4393.29707246839;3903.6096390361304;3915.5497117831246;3918.0792513759243;3931.8230679619487;3957.5053118360206;5160.587153027824;5338.733063346817;5346.5455436287575;5352.785888564414;5397.2443857859935;5560.582956278296;5588.888222235532;5600.691961942132;5630.493255607015;5648.576356773258;5274.314339135888;5284.7886084556185;5287.603429742785;5288.312519372457;5291.735413229323;4758.976205118952;4869.415670119608;4906.484819093944;4909.975450122798;4943;5761.683107429048;5872.677002764889;5887.20522729426;5897.144913987448;5941.673207973517;5691.857703557362;5698.743556540048;5699.316082070178;5706.771729130788;5709.314882214161;5646.322441306905;5789.2763404574425;5821.243238378984;5849.795257165979;5870.589058765845;5610;5612.607117501736;5618.988582055269;5637.46444087811;5678.488935995781;5636.098224284095;5672.290963629546;5678.119891416837;5684.090545512699;5685.687287199244;5373.758180881791;5433.185022246695;5472.50747432733;5485.533729633026;5505.201745746765;5489.204065410573;5499.120140777456;5499.532539734168;5516.172574113754;5530.861728456821;5413.296271484839;5457.918131228114;5460.672359658433;5465.836024919259;5508.834734957958;5427.267318911896;5446.074167391474;5465.371482279589;5485.341758988947;5579.776808927598;5377.838664840061;5407.242985981887;5414.566834653139;5416.025115479251;5451.37309209446 08:24:31 INFO - PROCESS | 11665 | |1;ext.html;604.2386592892954;626.7117126121983;636.1570918532942;646.6023395611697;652.6116960408561;31309.21726956827;42865;43501.56498435019;43507.78246108773;43556;43400.13199736003;43621;43849.34225986613;43871.780641096826;43903.78048109763;8545.572721363938;8588.613512391958;8711.60797764099;8715;8721.60752766127;8601.913980860205;8715.128487151298;8716.128387161296;8717.520536370497;8721.302295816351;8737.344699147558;8738;8773.692920747775;8790.120987901222;8793.692220772275;8644.827103457927;8681.826363472695;8682.392232543725;8692.087330830267;8693.652253909837;8581.485110893303;8665.610047547876;8668.566571671454;8670.696525621635;8673.956630216871;40448.59551404478;40597;41023.589764102275;41051;41140.38289425661;3394.287199688044;3404.6595340466;3412.897613071612;3622.3479773640734;4095.201435720036;30185.698143018508;30387.392252154834;30412.087637370914;30539;31964.84017579897;3562.8752993645357;3583.516225309602;3697.2235830475634;3712.962870371289;3718.535183102112;210888;211228;211531;211812;212120;52059;52189.7390513045;52245;55934;56090.43909560852;59729.402705973254;59952.40047599556;60301;66897.65165264242;67078;16697.165141742866;16858.494245172664;16860.156992150343;16862.83137168637;16866.915665421595;12373.257604543576;12913.677158071123;12956.80564791529;12968.610941671765;13169.144005639795;16755.91622041882;17155.656886862194;17453.65092698164;17480;17532.474025779247;6160.8767824643255;6169.413905678954;6315.147455093504;6332.182178930332;6333.936660633335;929.3030227329502;1044.1490185498794;1062.516554967488;1106.1703722208345;1136.2784631758893;32205.298937421467;32482.675173248437;32516.674833251363;32712.672873270963;32972.17569560732;1121.3664279681955;1125.7129431994952;1151.2977083978767;1173.5364531010373;1202.0984261803646;15900.92049539745;16788.916055419646;16859;16984.74522882158;17064.658706825794;143859.2807035958;145557;146092;146861;147665;58497;58623;58692.41307586955;59074.40925590775;59160;1255.811628255769;1384.190248704519;1385.778275475919;1531.2420351925869;1615.7091723489884;31326.686733132377;33742.156446089044;33952.320953581286;34259.65740342565;34452;51102;51980;52032.219516708035;52087.739561301954;52207.21689174741;543399;550709;551998;552209;553903;33620.66379336175;42500.57499424966;43052.35421468618;46691.766541167075;47176.7641161792;48175.759121204166;49050.509494904596;49119.50880491149;51839.74080129575;52593.7370313146;41236.58763412327;43128.784356079275;43788.781056094514;45146.322805158605;45313.09373812439;43311.56688433075;43415.34876976911;43998;44025.339619906365;44248;43965.120697586506;44590.3311450322;44751.32873006973;44978;44987.100257994;34036.659633403346;36504;36904.42992590279;37038;37283.627163728015;28964.7103528962;29210.415791683623;29240.41519169562;29795.851020745624;29920.401591968475 08:24:31 INFO - PROCESS | 11665 | |2;jquery.html;375.07918061159864;385.1776457263741;391.47346818529076;403.95354534228574;409.72138945517054;17781.911090444544;19448.902755486204;19916.90041549792;19926.10332535036;19956.60086798265;18111.275548978057;18427.262909483605;18621.975791331504;18824.24703011881;19018.524536886584;5498.972505137469;5558.86102847428;5577;5622.465865742748;5687.516561092312;5391.487808658191;5401.378841433227;5444.183372494118;5501.9174712379145;5539.279893613824;5439.564834813205;5447.727613619323;5456.0997435423105;5458.372287186965;5566.192902029204;5380.139177731583;5508.14623733322;5565.554755619541;5568.916466253009;5584.6090773645865;4824.638152138604;4908.705477671351;4919.286703428019;4953.727544985024;4958.925616115761;21581.46046348838;21780.01989910458;21968.45078873025;22223.777762222493;22274.777252227595;2223.8332125090683;2295.9540809183723;2300.907963681451;2303.4586872085047;2319.0028287836226;8219.671213151467;13258.204507729568;13930.791038134435;13961.417137829534;14110.576682699535;1874.372085351409;1895.895725735084;1962.519182800223;1967.3507742444958;1977.6143651987868;58991.70504147495;74421.62789186019;77627.22372776257;78017.60991195064;78327;9533.761655958519;9663.27525435595;9805.235057689542;9932;10009.349392289623;13274.867251327363;13324.866751332362;13349.332533373292;13358.532451364155;13365.599032029055;7846.646900889474;7863.292303692695;8114.066882308492;8153.551554664432;8305.750827475185;8122.553259570662;8184.713535026364;8385.203405676451;8408.2432581068;8438.409311348269;6108.725107370179;6276.246850377984;6300.8424789379715;6328.145700330489;6362.840928976812;1702.3956495444186;1702.455214331402;1734.2889415339903;1748.728947013215;1765.920533575992;977.6040703515088;981.6466072213997;989.1789814453986;1030.5568605499557;1056.1972900595604;17979.370722024927;18999.240030398905;19098.33155839567;19179.520511987314;19340.32308869211;992.5781542844262;1008.8537162111453;1018.5263852308564;1041.7447725307347;1049.9002594753485;10643.254972151875;10945.011720767669;10967.396793176453;10978.176636752276;10979.39613321275;469583;478149;482320;484105;485784;80531;81779.59110204411;81809;81965.18034819695;82146.53560393197;1018.9032041956151;1021.7547788530848;1064.5794911010262;1079.881213066562;1081.8564896446592;16672.833271667612;16834.326626934784;16896.662066758843;17031;17318.480445586654;35365.469517956735;36213.45679814752;36790.26419471649;36940;39126;57651.42348576461;57701;58065.709671451375;58930.70534647299;60199.69900150471;8039.758807235792;8057.798555036171;8121.8375632488205;8140.83718325642;8283.29591984664;9095.090490950852;11847.348395837967;12856.742865142833;12921.806172907225;13080.869191308346;10929.890701093205;11376.601818936297;11548.80572691186;11671.241369310968;12097.640960012714;10841.837372439577;11213.159013074215;11240.943795280971;11429.314241145557;11472.713182170179;10962.831257304546;11555.88444115548;11962;12018.33899135556;12069.456874440846;8081;8156.632951517077;8271.966004249469;8423.70517031901;8488.787780305542;8378.120297368689;10655.25413221067;11512.59705910289;11609.941950290195;11749.76500470003 08:24:31 INFO - PROCESS | 11665 | |3;mootools.html;1332.4670131947225;1487.761958086706;1536.4161618584935;1653.8428849259317;1795.946121616351;8198.42611017229;8452.746417607474;8491.787705307363;8685.696000639962;8790.208881200706;8604.440711353758;8768.824623507542;8784.429012114208;8791;8809.86785198221;2236.854604450714;2261.016457840836;2265.501589650274;2266.1388672304583;2268.0474200835606;2238.7985081342676;2286.4398222435525;2288.553732022248;2293.380787187467;2296.0471404367167;2245.764194759551;2246.955060898781;2253.9774602253933;2270.795628393444;2274.5678321118935;2117.7246957895527;2139.1336508713916;2155.3426205007468;2157.4390658428765;2167.143978128638;2180.160638154322;2187.9124835006583;2191.9890400548056;2192.1450634252496;2193.714817073786;8483.278921291698;8601.354898382646;8610.095939926343;8715.956420217859;8964.68623598171;5129.230615407681;5242.580593552507;5246.895062098775;5248.7375631218665;5248.9737551312;3253.6420993690676;3259.4621887388553;3261.8858339957987;3319.6348401675796;3321.219513414346;1018.9949050254776;1031.1441503552035;1055.5091882274703;1064.4784055812675;1065.0414626835832;12691.11162218645;12782.680432989157;12831.550895718698;12850.421731022034;12856.807147892789;4262.126264115849;4288.957110428918;4330.783460826946;4347.760873152007;4363;9913.950430247802;9966.40201587907;9984.450855203033;9988.200943924468;9998.400095994264;5037.29477873098;5037.622178336566;5045.722485263345;5048.899022019613;5053.84838454847;4086.4074709167003;4262.403263543107;4743.644226683013;4811.08589368019;4847.854564363075;3608.224231790178;3621.27574485104;3648.7993160376436;3676.7793932364143;3689.4834723138783;1015.1016350529834;1031.8855635913196;1038.065740833256;1039.8128336899279;1060.1201003167353;939.2955283537347;986.3785814936688;1004.3371374892536;1016.8169729448622;1022.9489872804978;5934.554908381889;6150.892839288881;6164.7842325518395;6216.813495595139;6357.448250431043;435.1319118358894;435.37741030326936;443.59411138807627;452.27184233384224;454.78170478170665;4287.549807270254;4328.091100868853;4337.783110844445;4352.39066530686;4437.711548749321;11087.113030957504;11451.599194028335;11507.482163302671;11519.19365644397;11536.134789890792;11275.943620281847;11373.715657108638;11378.08975281992;11378.601748938747;11398.430078496041;7982.680692772224;8292.17078292178;8308.584570771438;8520.360972926932;8529.402941794138;5993.700314984146;6268.435840774352;6346.841328966812;6356.98288273874;6432.742690292524;10239.7440063999;10379.377237365481;10537.42044187577;10629.468526573486;10674.199435042558;10545.31455455393;10700.732481688021;10815.080718139046;10823.134149267882;10838.945805270923;8056.234657707509;8253.628586713732;8265;8267.049289331804;8270.586470676562;8486.19381158789;8561.657533698582;8663.870041949249;8691.782705432415;8788.296936244957;7859.410544209093;7884.29041386278;7902.644381002754;7941.523508589503;8032.919670803217;7686.846263074595;7699.499532530368;7783.299503044526;7837.725679601187;7983.081945576333;7311;7472.551646901204;7478.2895624915545;7484.588347640932;7486.513376630502;5092.872678183075;5400.243965844864;5492.258545096521;5548.583856210881;5606.18710286998;5105.540501354896;5117.667351622133;5174.301469301747;5333.946660533345;5615.803446879339 08:24:31 INFO - PROCESS | 11665 | |4;prototype.html;295.4652079735679;297.98957036503725;301.72995169323457;302.5975452647978;304.4307145637658;5186.559142472895;5197.116490196666;5209.124715102565;5217.608679349045;5228.73856307185;5164.096283150452;5167.586593072555;5168.113638521941;5184.196449550316;5189.014087323406;3884.495015647969;3924.9803750981205;4002.2195671844;4019.8995025124314;4034.7780872052026;4032.3749818777987;4032.6087499812515;4041.3533834586474;4054.2904991626497;4055.2700513907484;3854.402567602026;4006.0786019215598;4021;4023.9678962124085;4024.5170579530495;3741.7754934704003;3957.4474463970723;3994.8202330895033;4030.294698427793;4055.959440405588;3514.876979305712;3515.789052656849;3545.2200515886466;3545.5745310562897;3548.982255088734;5013.473585273567;5048.747562621891;5058.052649729843;5085.771140298659;5097.490250974873;4499;4577.885552861205;4587.128445595359;4591.95408045922;4594.437891117036;5317.175837745156;5354.7416357156035;5372.194170874361;5381.354237491526;5401.810936617199;3857.209272099241;3871.2838124946693;3877.6316249956208;3901;3901.941470877939;5368.91946620801;5592.098686446587;5635.6055076144685;5654.717264136818;5704;3890.8638197662945;3908.5895980922164;3908.8241029153755;3926.155876486569;3936.527616685959;3941.172353805733;3993.6805055595482;3995.2409042281874;4002.3196056670436;4027.4764280643913;4304.763238021939;4550.453945526492;4595.310703394518;4608.28571571407;4632.72203667781;5500.257465242221;5500.367457742411;5501.449855014466;5502.532284755841;5508.209831804679;1341.3025226882162;1343.8320209973754;1350.4058214385639;1355.8372995240436;1365.7951307303983;823.81052357958;855.7676945198893;858.2318824651902;869.096140014378;871.9215270625674;5105.489451054865;5174.197999310113;5188.662736922088;5197.610179236573;5262.236975638511;5528.115501519737;5558.360788509292;5575.303087114111;5579.832605021856;5609;4999.42506611737;5206.167013277857;5209.791608335624;5215.713135777569;5256.947430525723;2953.2469220349103;2964.570137330118;2965.5996440480258;2975.152081656761;2987.970120298769;5749.1663708762;5786.2477877876445;5786.479216870502;5789.363170051291;5804.593678442553;5486.753096110685;5725.856853578611;5819.679917604572;5828.679422631796;5831.504322132666;5800.4489573490455;5804.24298458229;5829.650220986754;5858.765649373977;5868.413158684012;5537.1140617501005;5657.179708942098;5683.5737319700365;5703.089465029262;5704.80033198836;5563.358809151391;5574.275344205227;5575.721213939206;5591.580631452576;5603.80386686464;5752.28096487939;5760.654360738369;5765.7117144141785;5779.682117483579;5828.213191219301;3731.067233191702;3781.4138808484727;3797.050737315671;3804.524434445694;3826.2730081284467;5601.831945041656;5630.0991841305195;5644;5645.379008309164;5645.71771411436;5507.9449205507435;5508.76052888097;5511.586631002771;5514.944850551443;5519.365272993497;5374.973125134349;5463.453654634504;5477.178423236546;5500.312460942382;5503.2114562766465;5163.638545301793;5378.354597448331;5384.407715151408;5387.703676297841;5399.919001215064;5298.44366341544;5399.622026458111;5421.241026256406;5426.186072089218;5465.781368745205;5325.295905310263;5329.946700532945;5370;5379.67721936685;5387.81142660005 08:24:31 INFO - PROCESS | 11665 | |5;yui.html;656.8719099775545;674.5278305186371;731.2212493694216;798.5089170160352;809.5466538738307;14737;15309.846901530982;15830.60423489412;15849.445269415573;15885.920570397146;14317.92841035796;14366.281685915716;14387.208703521303;14390.1365918045;14407.135571865669;664.5215444879703;778.3111945927866;792.2869417524231;804.3082948664144;813.6257321632056;784.3803395317692;789.8736202207648;790.4348390900504;791.8060075281535;791.8970533830594;835.6657337065162;838.9538575378351;839.492107275099;839.937004724645;839.9790005249856;685.5783693028776;816.5508970066439;833.7707130539089;834.8914641096679;845.0366582096415;613.1385403508078;616.1774031667729;616.1804799616499;617.450469082517;617.6355949989482;13927.930360348235;14019.789703154358;14052.227127507984;14069.366878490493;14076.296185190802;12563.560275390317;13090.672733181651;13307.667308317272;13441.395137218751;13854.376553055137;11382.658520244324;11518.942405288004;11789.705257368549;12093.45579448927;12167.330796806173;4282.462865356963;4311.504177019651;4337.4116664844305;4356.455443069616;4383.780810959471;69646.303536965;70142.29857701408;70333;70529.64735176343;70648.29351706468;9986.300958932805;9999.650012249682;10027.749306267257;10217.795644087226;10423.583056677648;19629.901850490656;19723.605527889362;19753.60492790136;19767.505812354808;19935.20259189645;7282.781516554512;7637.923620763832;7766.417518686008;7828.060632723996;7938.801529961797;4105.609967053185;4122.56713045126;4189.748615083105;4220.261454245495;4317.740935543878;3378.5438965739804;3482.721382289411;3498.8775392861126;3533.4876442915634;3535.6641119093647;591.0189086117111;597.7130977131002;599.4784537452445;602.3976023976024;606.7633622887078;558.1404636859272;572.4275724275724;630.2090875950653;648.9578177418452;665.434380776346;7931.682732690743;8173.305269052197;8652.567371631394;8731.013036718035;9055.637774489078;570.0195663458844;636.818506725581;638.6742761191733;675.7263308360122;678.4320900356531;4539.795709193094;4564.817407303671;4641.535846415331;4671.789769460383;4715.4577223619035;111696;113418.3290835455;114623;114989.4250528742;116966;63174;85365.57317213374;88377.55811220902;92148.53925730463;95442.52278738562;81740.59129704432;82468.58765706253;83491.58254208691;85324;85436.99999999876;8741.91258087411;8759.824803504021;8898.644054237759;9071.863922041042;9088.681896133603;44005;45851.3122303159;50602.49397505978;51636.48363516317;52300.21549676682;71962;72193.27806721865;73431.63284183545;74604.25395745973;75072.62463687647;11934.820977685515;12002.1598488105;12028;12503.437345319664;12758.425870835648;13473.595792126252;13588;13953.441862325393;14171.433142674177;14270.143791372551;12424.689382765504;13378.464861405435;13425.798613020617;13449.86550134486;13510.662233444242;13417.396217170446;13464;13935.163890166623;14238.35927383291;14383.856161438252;12744.553940612033;12851.421686023965;12877.425109640899;12918.870811291767;12946.417411216706;10813.567457301935;10942.945285273523;11092.667219983414;11180.664580062612;11391.829122563002;11034.448277586249;11049.668509944715;11107.38909359993;11180.608678696206;11223.71940701489 08:24:31 INFO - PROCESS | 11665 | __end_tp_report 08:24:31 INFO - PROCESS | 11665 | __start_cc_report 08:24:31 INFO - PROCESS | 11665 | _x_x_mozilla_cycle_collect,998 08:24:31 INFO - PROCESS | 11665 | __end_cc_report 08:24:31 INFO - PROCESS | 11665 | __startTimestamp1465313071911__endTimestamp 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | ------- Summary: start ------- 08:24:31 INFO - PROCESS | 11665 | Number of tests: 6 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | [#0] dojo.html Cycles:165 Average:5259.65 Median:5427.27 stddev:572.62 (10.6%) stddev-sans-first:549.57 08:24:31 INFO - PROCESS | 11665 | Values: 3134.4 3136.2 3160.5 3163.3 3201.4 5100.6 5195.7 5212.0 5302.0 5314.3 5281.4 5281.8 5318.2 5321.0 5332.3 4751.3 4780.1 4886.4 4955.8 4974.6 4937.7 4949.0 4952.5 4959.9 4972.8 4691.6 4797.1 4842.3 4844.2 4873.7 4850.8 4851.5 4858.0 4865.0 4898.6 4818.6 4836.6 4867.4 4867.5 4893.4 5081.2 5142.1 5175.4 5207.7 5278.4 5583.0 5741.0 5757.5 5758.0 5766.4 5731.7 5748.1 5788.2 5803.5 5804.1 5147.5 5239.6 5259.6 5260.0 5341.7 5847.4 5855.0 5859.6 5863.7 5871.0 5617.4 5623.9 5634.1 5653.5 5660.2 5474.3 5566.9 5571.1 5603.6 5636.8 5594.2 5602.6 5610.8 5614.0 5619.1 5397.7 5580.2 5583.6 5586.7 5589.0 4339.3 4372.7 4375.4 4392.2 4393.3 3903.6 3915.5 3918.1 3931.8 3957.5 5160.6 5338.7 5346.5 5352.8 5397.2 5560.6 5588.9 5600.7 5630.5 5648.6 5274.3 5284.8 5287.6 5288.3 5291.7 4759.0 4869.4 4906.5 4910.0 4943.0 5761.7 5872.7 5887.2 5897.1 5941.7 5691.9 5698.7 5699.3 5706.8 5709.3 5646.3 5789.3 5821.2 5849.8 5870.6 5610.0 5612.6 5619.0 5637.5 5678.5 5636.1 5672.3 5678.1 5684.1 5685.7 5373.8 5433.2 5472.5 5485.5 5505.2 5489.2 5499.1 5499.5 5516.2 5530.9 5413.3 5457.9 5460.7 5465.8 5508.8 5427.3 5446.1 5465.4 5485.3 5579.8 5377.8 5407.2 5414.6 5416.0 5451.4 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | [#1] ext.html Cycles:180 Average:49254.32 Median:43220.18 stddev:94096.46 (217.7%) stddev-sans-first:94289.53 08:24:31 INFO - PROCESS | 11665 | Values: 604.2 626.7 636.2 646.6 652.6 31309.2 42865.0 43501.6 43507.8 43556.0 43400.1 43621.0 43849.3 43871.8 43903.8 8545.6 8588.6 8711.6 8715.0 8721.6 8601.9 8715.1 8716.1 8717.5 8721.3 8737.3 8738.0 8773.7 8790.1 8793.7 8644.8 8681.8 8682.4 8692.1 8693.7 8581.5 8665.6 8668.6 8670.7 8674.0 40448.6 40597.0 41023.6 41051.0 41140.4 3394.3 3404.7 3412.9 3622.3 4095.2 30185.7 30387.4 30412.1 30539.0 31964.8 3562.9 3583.5 3697.2 3713.0 3718.5 210888.0 211228.0 211531.0 211812.0 212120.0 52059.0 52189.7 52245.0 55934.0 56090.4 59729.4 59952.4 60301.0 66897.7 67078.0 16697.2 16858.5 16860.2 16862.8 16866.9 12373.3 12913.7 12956.8 12968.6 13169.1 16755.9 17155.7 17453.7 17480.0 17532.5 6160.9 6169.4 6315.1 6332.2 6333.9 929.3 1044.1 1062.5 1106.2 1136.3 32205.3 32482.7 32516.7 32712.7 32972.2 1121.4 1125.7 1151.3 1173.5 1202.1 15900.9 16788.9 16859.0 16984.7 17064.7 143859.3 145557.0 146092.0 146861.0 147665.0 58497.0 58623.0 58692.4 59074.4 59160.0 1255.8 1384.2 1385.8 1531.2 1615.7 31326.7 33742.2 33952.3 34259.7 34452.0 51102.0 51980.0 52032.2 52087.7 52207.2 543399.0 550709.0 551998.0 552209.0 553903.0 33620.7 42500.6 43052.4 46691.8 47176.8 48175.8 49050.5 49119.5 51839.7 52593.7 41236.6 43128.8 43788.8 45146.3 45313.1 43311.6 43415.3 43998.0 44025.3 44248.0 43965.1 44590.3 44751.3 44978.0 44987.1 34036.7 36504.0 36904.4 37038.0 37283.6 28964.7 29210.4 29240.4 29795.9 29920.4 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | [#2] jquery.html Cycles:180 Average:27936.92 Median:36501.86 stddev:78883.74 (216.1%) stddev-sans-first:79077.88 08:24:31 INFO - PROCESS | 11665 | Values: 375.1 385.2 391.5 404.0 409.7 17781.9 19448.9 19916.9 19926.1 19956.6 18111.3 18427.3 18622.0 18824.2 19018.5 5499.0 5558.9 5577.0 5622.5 5687.5 5391.5 5401.4 5444.2 5501.9 5539.3 5439.6 5447.7 5456.1 5458.4 5566.2 5380.1 5508.1 5565.6 5568.9 5584.6 4824.6 4908.7 4919.3 4953.7 4958.9 21581.5 21780.0 21968.5 22223.8 22274.8 2223.8 2296.0 2300.9 2303.5 2319.0 8219.7 13258.2 13930.8 13961.4 14110.6 1874.4 1895.9 1962.5 1967.4 1977.6 58991.7 74421.6 77627.2 78017.6 78327.0 9533.8 9663.3 9805.2 9932.0 10009.3 13274.9 13324.9 13349.3 13358.5 13365.6 7846.6 7863.3 8114.1 8153.6 8305.8 8122.6 8184.7 8385.2 8408.2 8438.4 6108.7 6276.2 6300.8 6328.1 6362.8 1702.4 1702.5 1734.3 1748.7 1765.9 977.6 981.6 989.2 1030.6 1056.2 17979.4 18999.2 19098.3 19179.5 19340.3 992.6 1008.9 1018.5 1041.7 1049.9 10643.3 10945.0 10967.4 10978.2 10979.4 469583.0 478149.0 482320.0 484105.0 485784.0 80531.0 81779.6 81809.0 81965.2 82146.5 1018.9 1021.8 1064.6 1079.9 1081.9 16672.8 16834.3 16896.7 17031.0 17318.5 35365.5 36213.5 36790.3 36940.0 39126.0 57651.4 57701.0 58065.7 58930.7 60199.7 8039.8 8057.8 8121.8 8140.8 8283.3 9095.1 11847.3 12856.7 12921.8 13080.9 10929.9 11376.6 11548.8 11671.2 12097.6 10841.8 11213.2 11240.9 11429.3 11472.7 10962.8 11555.9 11962.0 12018.3 12069.5 8081.0 8156.6 8272.0 8423.7 8488.8 8378.1 10655.3 11512.6 11609.9 11749.8 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | [#3] mootools.html Cycles:180 Average:5857.66 Median:2403.30 stddev:3461.90 (144.0%) stddev-sans-first:3454.91 08:24:31 INFO - PROCESS | 11665 | Values: 1332.5 1487.8 1536.4 1653.8 1795.9 8198.4 8452.7 8491.8 8685.7 8790.2 8604.4 8768.8 8784.4 8791.0 8809.9 2236.9 2261.0 2265.5 2266.1 2268.0 2238.8 2286.4 2288.6 2293.4 2296.0 2245.8 2247.0 2254.0 2270.8 2274.6 2117.7 2139.1 2155.3 2157.4 2167.1 2180.2 2187.9 2192.0 2192.1 2193.7 8483.3 8601.4 8610.1 8716.0 8964.7 5129.2 5242.6 5246.9 5248.7 5249.0 3253.6 3259.5 3261.9 3319.6 3321.2 1019.0 1031.1 1055.5 1064.5 1065.0 12691.1 12782.7 12831.6 12850.4 12856.8 4262.1 4289.0 4330.8 4347.8 4363.0 9914.0 9966.4 9984.5 9988.2 9998.4 5037.3 5037.6 5045.7 5048.9 5053.8 4086.4 4262.4 4743.6 4811.1 4847.9 3608.2 3621.3 3648.8 3676.8 3689.5 1015.1 1031.9 1038.1 1039.8 1060.1 939.3 986.4 1004.3 1016.8 1022.9 5934.6 6150.9 6164.8 6216.8 6357.4 435.1 435.4 443.6 452.3 454.8 4287.5 4328.1 4337.8 4352.4 4437.7 11087.1 11451.6 11507.5 11519.2 11536.1 11275.9 11373.7 11378.1 11378.6 11398.4 7982.7 8292.2 8308.6 8520.4 8529.4 5993.7 6268.4 6346.8 6357.0 6432.7 10239.7 10379.4 10537.4 10629.5 10674.2 10545.3 10700.7 10815.1 10823.1 10838.9 8056.2 8253.6 8265.0 8267.0 8270.6 8486.2 8561.7 8663.9 8691.8 8788.3 7859.4 7884.3 7902.6 7941.5 8032.9 7686.8 7699.5 7783.3 7837.7 7983.1 7311.0 7472.6 7478.3 7484.6 7486.5 5092.9 5400.2 5492.3 5548.6 5606.2 5105.5 5117.7 5174.3 5333.9 5615.8 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | [#4] prototype.html Cycles:180 Average:4571.48 Median:5212.75 stddev:1372.67 (26.3%) stddev-sans-first:1338.47 08:24:31 INFO - PROCESS | 11665 | Values: 295.5 298.0 301.7 302.6 304.4 5186.6 5197.1 5209.1 5217.6 5228.7 5164.1 5167.6 5168.1 5184.2 5189.0 3884.5 3925.0 4002.2 4019.9 4034.8 4032.4 4032.6 4041.4 4054.3 4055.3 3854.4 4006.1 4021.0 4024.0 4024.5 3741.8 3957.4 3994.8 4030.3 4056.0 3514.9 3515.8 3545.2 3545.6 3549.0 5013.5 5048.7 5058.1 5085.8 5097.5 4499.0 4577.9 4587.1 4592.0 4594.4 5317.2 5354.7 5372.2 5381.4 5401.8 3857.2 3871.3 3877.6 3901.0 3901.9 5368.9 5592.1 5635.6 5654.7 5704.0 3890.9 3908.6 3908.8 3926.2 3936.5 3941.2 3993.7 3995.2 4002.3 4027.5 4304.8 4550.5 4595.3 4608.3 4632.7 5500.3 5500.4 5501.4 5502.5 5508.2 1341.3 1343.8 1350.4 1355.8 1365.8 823.8 855.8 858.2 869.1 871.9 5105.5 5174.2 5188.7 5197.6 5262.2 5528.1 5558.4 5575.3 5579.8 5609.0 4999.4 5206.2 5209.8 5215.7 5256.9 2953.2 2964.6 2965.6 2975.2 2988.0 5749.2 5786.2 5786.5 5789.4 5804.6 5486.8 5725.9 5819.7 5828.7 5831.5 5800.4 5804.2 5829.7 5858.8 5868.4 5537.1 5657.2 5683.6 5703.1 5704.8 5563.4 5574.3 5575.7 5591.6 5603.8 5752.3 5760.7 5765.7 5779.7 5828.2 3731.1 3781.4 3797.1 3804.5 3826.3 5601.8 5630.1 5644.0 5645.4 5645.7 5507.9 5508.8 5511.6 5514.9 5519.4 5375.0 5463.5 5477.2 5500.3 5503.2 5163.6 5378.4 5384.4 5387.7 5399.9 5298.4 5399.6 5421.2 5426.2 5465.8 5325.3 5329.9 5370.0 5379.7 5387.8 08:24:31 INFO - PROCESS | 11665 | 08:24:31 INFO - PROCESS | 11665 | [#5] yui.html Cycles:180 Average:19746.53 Median:25208.06 stddev:28451.34 (112.9%) stddev-sans-first:28495.04 08:24:31 INFO - PROCESS | 11665 | Values: 656.9 674.5 731.2 798.5 809.5 14737.0 15309.8 15830.6 15849.4 15885.9 14317.9 14366.3 14387.2 14390.1 14407.1 664.5 778.3 792.3 804.3 813.6 784.4 789.9 790.4 791.8 791.9 835.7 839.0 839.5 839.9 840.0 685.6 816.6 833.8 834.9 845.0 613.1 616.2 616.2 617.5 617.6 13927.9 14019.8 14052.2 14069.4 14076.3 12563.6 13090.7 13307.7 13441.4 13854.4 11382.7 11518.9 11789.7 12093.5 12167.3 4282.5 4311.5 4337.4 4356.5 4383.8 69646.3 70142.3 70333.0 70529.6 70648.3 9986.3 9999.7 10027.7 10217.8 10423.6 19629.9 19723.6 19753.6 19767.5 19935.2 7282.8 7637.9 7766.4 7828.1 7938.8 4105.6 4122.6 4189.7 4220.3 4317.7 3378.5 3482.7 3498.9 3533.5 3535.7 591.0 597.7 599.5 602.4 606.8 558.1 572.4 630.2 649.0 665.4 7931.7 8173.3 8652.6 8731.0 9055.6 570.0 636.8 638.7 675.7 678.4 4539.8 4564.8 4641.5 4671.8 4715.5 111696.0 113418.3 114623.0 114989.4 116966.0 63174.0 85365.6 88377.6 92148.5 95442.5 81740.6 82468.6 83491.6 85324.0 85437.0 8741.9 8759.8 8898.6 9071.9 9088.7 44005.0 45851.3 50602.5 51636.5 52300.2 71962.0 72193.3 73431.6 74604.3 75072.6 11934.8 12002.2 12028.0 12503.4 12758.4 13473.6 13588.0 13953.4 14171.4 14270.1 12424.7 13378.5 13425.8 13449.9 13510.7 13417.4 13464.0 13935.2 14238.4 14383.9 12744.6 12851.4 12877.4 12918.9 12946.4 10813.6 10942.9 11092.7 11180.7 11391.8 11034.4 11049.7 11107.4 11180.6 11223.7 08:24:31 INFO - PROCESS | 11665 | -------- Summary: end -------- 08:24:31 INFO - PROCESS | 11665 | 08:24:32 INFO - TEST-INFO | 11665: exit 0 08:24:32 INFO - TEST-OK | dromaeo_css | took 1112254ms 08:24:32 INFO - TEST-START | kraken 08:24:32 INFO - operating with platform_type : linux_ 08:24:32 INFO - Initialising browser for kraken test... 08:24:32 INFO - TEST-INFO | started process 11844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppu77aU/profile http://localhost:41262/getInfo.html) 08:24:36 INFO - PROCESS | 11844 | __metrics Screen width/height:1600/1200 08:24:36 INFO - PROCESS | 11844 | colorDepth:24 08:24:36 INFO - PROCESS | 11844 | Browser inner width/height: 1024/697 08:24:36 INFO - PROCESS | 11844 | __metrics 08:24:37 ERROR - PROCESS | 11844 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:24:37 INFO - PROCESS | 11844 | console.error: PushService: 08:24:37 INFO - PROCESS | 11844 | stateChangeProcessEnqueue: Error transitioning state 08:24:37 INFO - PROCESS | 11844 | UnknownError 08:24:38 INFO - TEST-INFO | 11844: exit 0 08:24:38 INFO - Browser initialized. 08:24:38 INFO - Running cycle 1/1 for kraken test... 08:24:38 INFO - TEST-INFO | started process 11925 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppu77aU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:50 INFO - PROCESS | 11925 | RSS: Main: 156798976 08:24:50 INFO - PROCESS | 11925 | 08:24:52 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41262/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:53 INFO - PROCESS | 11925 | RSS: Main: 214208512 08:24:53 INFO - PROCESS | 11925 | 08:24:56 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41262/tests/kraken/driver.html?testName=audio-dft) 08:24:56 INFO - PROCESS | 11925 | RSS: Main: 202711040 08:24:56 INFO - PROCESS | 11925 | 08:25:00 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41262/tests/kraken/driver.html?testName=audio-fft) 08:25:00 INFO - PROCESS | 11925 | RSS: Main: 269127680 08:25:00 INFO - PROCESS | 11925 | 08:25:02 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41262/tests/kraken/driver.html?testName=audio-oscillator) 08:25:03 INFO - PROCESS | 11925 | RSS: Main: 179339264 08:25:03 INFO - PROCESS | 11925 | 08:25:05 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:06 INFO - PROCESS | 11925 | RSS: Main: 184328192 08:25:06 INFO - PROCESS | 11925 | 08:25:09 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41262/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:09 INFO - PROCESS | 11925 | RSS: Main: 219787264 08:25:09 INFO - PROCESS | 11925 | 08:25:13 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41262/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:13 INFO - PROCESS | 11925 | RSS: Main: 221106176 08:25:13 INFO - PROCESS | 11925 | 08:25:16 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41262/tests/kraken/driver.html?testName=json-parse-financial) 08:25:17 INFO - PROCESS | 11925 | RSS: Main: 220794880 08:25:17 INFO - PROCESS | 11925 | 08:25:18 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:19 INFO - PROCESS | 11925 | RSS: Main: 207060992 08:25:19 INFO - PROCESS | 11925 | 08:25:21 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:21 INFO - PROCESS | 11925 | RSS: Main: 210243584 08:25:21 INFO - PROCESS | 11925 | 08:25:23 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:24 INFO - PROCESS | 11925 | RSS: Main: 218140672 08:25:24 INFO - PROCESS | 11925 | 08:25:27 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:27 INFO - PROCESS | 11925 | RSS: Main: 223813632 08:25:27 INFO - PROCESS | 11925 | 08:25:30 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:31 INFO - PROCESS | 11925 | RSS: Main: 225841152 08:25:31 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | Cycle 1(1): loaded http://localhost:41262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41262/tests/kraken/driver.html?testName=ai-astar) 08:25:32 INFO - PROCESS | 11925 | RSS: Main: 267747328 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | __start_tp_report 08:25:32 INFO - PROCESS | 11925 | _x_x_mozilla_page_load 08:25:32 INFO - PROCESS | 11925 | _x_x_mozilla_page_load_details 08:25:32 INFO - PROCESS | 11925 | |i|pagename|runs| 08:25:32 INFO - PROCESS | 11925 | |0;ai-astar;114;109;111;110;111;110;111;109;110;110 08:25:32 INFO - PROCESS | 11925 | |1;audio-beat-detection;154;125;126;184;126;132;161;126;160;133 08:25:32 INFO - PROCESS | 11925 | |2;audio-dft;160;162;161;162;161;161;162;162;162;162 08:25:32 INFO - PROCESS | 11925 | |3;audio-fft;75;76;76;123;77;76;75;75;108;76 08:25:32 INFO - PROCESS | 11925 | |4;audio-oscillator;85;86;109;86;92;86;115;85;85;129 08:25:32 INFO - PROCESS | 11925 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 08:25:32 INFO - PROCESS | 11925 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;146 08:25:32 INFO - PROCESS | 11925 | |7;imaging-desaturate;95;95;96;94;95;95;95;95;96;95 08:25:32 INFO - PROCESS | 11925 | |8;json-parse-financial;55;54;53;55;53;55;54;53;54;53 08:25:32 INFO - PROCESS | 11925 | |9;json-stringify-tinderbox;61;61;61;61;62;61;61;61;61;62 08:25:32 INFO - PROCESS | 11925 | |10;stanford-crypto-aes;85;83;80;81;80;81;80;85;108;81 08:25:32 INFO - PROCESS | 11925 | |11;stanford-crypto-ccm;122;130;126;133;127;120;132;142;137;122 08:25:32 INFO - PROCESS | 11925 | |12;stanford-crypto-pbkdf2;161;159;159;159;161;162;160;160;160;160 08:25:32 INFO - PROCESS | 11925 | |13;stanford-crypto-sha256-iterative;64;68;63;63;67;63;62;64;62;62 08:25:32 INFO - PROCESS | 11925 | __end_tp_report 08:25:32 INFO - PROCESS | 11925 | __start_cc_report 08:25:32 INFO - PROCESS | 11925 | _x_x_mozilla_cycle_collect,1622 08:25:32 INFO - PROCESS | 11925 | __end_cc_report 08:25:32 INFO - PROCESS | 11925 | __startTimestamp1465313132961__endTimestamp 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | ------- Summary: start ------- 08:25:32 INFO - PROCESS | 11925 | Number of tests: 14 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:1.43 (1.3%) stddev-sans-first:0.78 08:25:32 INFO - PROCESS | 11925 | Values: 114.0 109.0 111.0 110.0 111.0 110.0 111.0 109.0 110.0 110.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:143.50 stddev:20.62 (14.4%) stddev-sans-first:21.46 08:25:32 INFO - PROCESS | 11925 | Values: 154.0 125.0 126.0 184.0 126.0 132.0 161.0 126.0 160.0 133.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.71 (0.4%) stddev-sans-first:0.50 08:25:32 INFO - PROCESS | 11925 | Values: 160.0 162.0 161.0 162.0 161.0 161.0 162.0 162.0 162.0 162.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:17.14 (22.6%) stddev-sans-first:17.89 08:25:32 INFO - PROCESS | 11925 | Values: 75.0 76.0 76.0 123.0 77.0 76.0 75.0 75.0 108.0 76.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.50 stddev:15.98 (18.7%) stddev-sans-first:16.46 08:25:32 INFO - PROCESS | 11925 | Values: 85.0 86.0 109.0 86.0 92.0 86.0 115.0 85.0 85.0 129.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:25:32 INFO - PROCESS | 11925 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:25:32 INFO - PROCESS | 11925 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:25:32 INFO - PROCESS | 11925 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.83 08:25:32 INFO - PROCESS | 11925 | Values: 55.0 54.0 53.0 55.0 53.0 55.0 54.0 53.0 54.0 53.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:25:32 INFO - PROCESS | 11925 | Values: 61.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 62.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:81.00 stddev:8.51 (10.5%) stddev-sans-first:9.03 08:25:32 INFO - PROCESS | 11925 | Values: 85.0 83.0 80.0 81.0 80.0 81.0 80.0 85.0 108.0 81.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:131.00 stddev:7.08 (5.4%) stddev-sans-first:7.03 08:25:32 INFO - PROCESS | 11925 | Values: 122.0 130.0 126.0 133.0 127.0 120.0 132.0 142.0 137.0 122.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 08:25:32 INFO - PROCESS | 11925 | Values: 161.0 159.0 159.0 159.0 161.0 162.0 160.0 160.0 160.0 160.0 08:25:32 INFO - PROCESS | 11925 | 08:25:32 INFO - PROCESS | 11925 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:2.10 (3.3%) stddev-sans-first:2.22 08:25:32 INFO - PROCESS | 11925 | Values: 64.0 68.0 63.0 63.0 67.0 63.0 62.0 64.0 62.0 62.0 08:25:32 INFO - PROCESS | 11925 | -------- Summary: end -------- 08:25:32 INFO - PROCESS | 11925 | 08:25:33 INFO - TEST-INFO | 11925: exit 0 08:25:33 INFO - TEST-OK | kraken | took 61199ms 08:25:33 INFO - SUITE-END | took 1173s 08:25:34 INFO - Completed test suite (00:19:33) 08:25:34 INFO - javascript benchmark 08:25:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.420132275528, 3136.1845920060787, 3160.4627213373724, 3163.3198862244612, 3201.4397480440916, 5100.566451851597, 5195.68825870448, 5212.035773381922, 5302.045631786282, 5314.335708036496, 5281.445448227938, 5281.788728450857, 5318.202269659553, 5321.0, 5332.33345831771, 4751.263554149113, 4780.067886762083, 4886.438059623136, 4955.752212389384, 4974.602031837462, 4937.728424936627, 4949.0, 4952.529509696573, 4959.876003099916, 4972.776225069881, 4691.62467002639, 4797.088553174903, 4842.2736589511505, 4844.249141383091, 4873.731944743037, 4850.75746212688, 4851.5391037851705, 4858.02839432115, 4864.951350486521, 4898.5591296783105, 4818.614510839125, 4836.613070954315, 4867.415910090812, 4867.464578896319, 4893.388326459192, 5081.237814327844, 5142.125838607409, 5175.404828444739, 5207.713575753332, 5278.419373868871, 5583.0, 5740.971295143498, 5757.539396848242, 5757.9712101439645, 5766.365699773021, 5731.656100633933, 5748.109043098327, 5788.18965344852, 5803.506701930341, 5804.1293805929445, 5147.459516750725, 5239.607029472805, 5259.5529380002745, 5260.026895024394, 5341.65279256847, 5847.386024467455, 5855.033919403336, 5859.589828712034, 5863.70681465925, 5871.031279838864, 5617.38208797032, 5623.915641265385, 5634.098544232903, 5653.519450846724, 5660.179274005246, 5474.315710536183, 5566.916496252559, 5571.0807716727095, 5603.551715862721, 5636.830895073154, 5594.24477695514, 5602.607817452821, 5610.775568977277, 5614.045612245928, 5619.129034999582, 5397.676139431646, 5580.19087232349, 5583.553315734732, 5586.748596313176, 5588.9720551397795, 4339.262325404688, 4372.715773474714, 4375.365571992107, 4392.231359512072, 4393.29707246839, 3903.6096390361304, 3915.5497117831246, 3918.0792513759243, 3931.8230679619487, 3957.5053118360206, 5160.587153027824, 5338.733063346817, 5346.5455436287575, 5352.785888564414, 5397.2443857859935, 5560.582956278296, 5588.888222235532, 5600.691961942132, 5630.493255607015, 5648.576356773258, 5274.314339135888, 5284.7886084556185, 5287.603429742785, 5288.312519372457, 5291.735413229323, 4758.976205118952, 4869.415670119608, 4906.484819093944, 4909.975450122798, 4943.0, 5761.683107429048, 5872.677002764889, 5887.20522729426, 5897.144913987448, 5941.673207973517, 5691.857703557362, 5698.743556540048, 5699.316082070178, 5706.771729130788, 5709.314882214161, 5646.322441306905, 5789.2763404574425, 5821.243238378984, 5849.795257165979, 5870.589058765845, 5610.0, 5612.607117501736, 5618.988582055269, 5637.46444087811, 5678.488935995781, 5636.098224284095, 5672.290963629546, 5678.119891416837, 5684.090545512699, 5685.687287199244, 5373.758180881791, 5433.185022246695, 5472.50747432733, 5485.533729633026, 5505.201745746765, 5489.204065410573, 5499.120140777456, 5499.532539734168, 5516.172574113754, 5530.861728456821, 5413.296271484839, 5457.918131228114, 5460.672359658433, 5465.836024919259, 5508.834734957958, 5427.267318911896, 5446.074167391474, 5465.371482279589, 5485.341758988947, 5579.776808927598, 5377.838664840061, 5407.242985981887, 5414.566834653139, 5416.025115479251, 5451.37309209446], "value": 5223.0590306217555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.2386592892954, 626.7117126121983, 636.1570918532942, 646.6023395611697, 652.6116960408561, 31309.21726956827, 42865.0, 43501.56498435019, 43507.78246108773, 43556.0, 43400.13199736003, 43621.0, 43849.34225986613, 43871.780641096826, 43903.78048109763, 8545.572721363938, 8588.613512391958, 8711.60797764099, 8715.0, 8721.60752766127, 8601.913980860205, 8715.128487151298, 8716.128387161296, 8717.520536370497, 8721.302295816351, 8737.344699147558, 8738.0, 8773.692920747775, 8790.120987901222, 8793.692220772275, 8644.827103457927, 8681.826363472695, 8682.392232543725, 8692.087330830267, 8693.652253909837, 8581.485110893303, 8665.610047547876, 8668.566571671454, 8670.696525621635, 8673.956630216871, 40448.59551404478, 40597.0, 41023.589764102275, 41051.0, 41140.38289425661, 3394.287199688044, 3404.6595340466, 3412.897613071612, 3622.3479773640734, 4095.201435720036, 30185.698143018508, 30387.392252154834, 30412.087637370914, 30539.0, 31964.84017579897, 3562.8752993645357, 3583.516225309602, 3697.2235830475634, 3712.962870371289, 3718.535183102112, 210888.0, 211228.0, 211531.0, 211812.0, 212120.0, 52059.0, 52189.7390513045, 52245.0, 55934.0, 56090.43909560852, 59729.402705973254, 59952.40047599556, 60301.0, 66897.65165264242, 67078.0, 16697.165141742866, 16858.494245172664, 16860.156992150343, 16862.83137168637, 16866.915665421595, 12373.257604543576, 12913.677158071123, 12956.80564791529, 12968.610941671765, 13169.144005639795, 16755.91622041882, 17155.656886862194, 17453.65092698164, 17480.0, 17532.474025779247, 6160.8767824643255, 6169.413905678954, 6315.147455093504, 6332.182178930332, 6333.936660633335, 929.3030227329502, 1044.1490185498794, 1062.516554967488, 1106.1703722208345, 1136.2784631758893, 32205.298937421467, 32482.675173248437, 32516.674833251363, 32712.672873270963, 32972.17569560732, 1121.3664279681955, 1125.7129431994952, 1151.2977083978767, 1173.5364531010373, 1202.0984261803646, 15900.92049539745, 16788.916055419646, 16859.0, 16984.74522882158, 17064.658706825794, 143859.2807035958, 145557.0, 146092.0, 146861.0, 147665.0, 58497.0, 58623.0, 58692.41307586955, 59074.40925590775, 59160.0, 1255.811628255769, 1384.190248704519, 1385.778275475919, 1531.2420351925869, 1615.7091723489884, 31326.686733132377, 33742.156446089044, 33952.320953581286, 34259.65740342565, 34452.0, 51102.0, 51980.0, 52032.219516708035, 52087.739561301954, 52207.21689174741, 543399.0, 550709.0, 551998.0, 552209.0, 553903.0, 33620.66379336175, 42500.57499424966, 43052.35421468618, 46691.766541167075, 47176.7641161792, 48175.759121204166, 49050.509494904596, 49119.50880491149, 51839.74080129575, 52593.7370313146, 41236.58763412327, 43128.784356079275, 43788.781056094514, 45146.322805158605, 45313.09373812439, 43311.56688433075, 43415.34876976911, 43998.0, 44025.339619906365, 44248.0, 43965.120697586506, 44590.3311450322, 44751.32873006973, 44978.0, 44987.100257994, 34036.659633403346, 36504.0, 36904.42992590279, 37038.0, 37283.627163728015, 28964.7103528962, 29210.415791683623, 29240.41519169562, 29795.851020745624, 29920.401591968475], "value": 19418.4519476941, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.07918061159864, 385.1776457263741, 391.47346818529076, 403.95354534228574, 409.72138945517054, 17781.911090444544, 19448.902755486204, 19916.90041549792, 19926.10332535036, 19956.60086798265, 18111.275548978057, 18427.262909483605, 18621.975791331504, 18824.24703011881, 19018.524536886584, 5498.972505137469, 5558.86102847428, 5577.0, 5622.465865742748, 5687.516561092312, 5391.487808658191, 5401.378841433227, 5444.183372494118, 5501.9174712379145, 5539.279893613824, 5439.564834813205, 5447.727613619323, 5456.0997435423105, 5458.372287186965, 5566.192902029204, 5380.139177731583, 5508.14623733322, 5565.554755619541, 5568.916466253009, 5584.6090773645865, 4824.638152138604, 4908.705477671351, 4919.286703428019, 4953.727544985024, 4958.925616115761, 21581.46046348838, 21780.01989910458, 21968.45078873025, 22223.777762222493, 22274.777252227595, 2223.8332125090683, 2295.9540809183723, 2300.907963681451, 2303.4586872085047, 2319.0028287836226, 8219.671213151467, 13258.204507729568, 13930.791038134435, 13961.417137829534, 14110.576682699535, 1874.372085351409, 1895.895725735084, 1962.519182800223, 1967.3507742444958, 1977.6143651987868, 58991.70504147495, 74421.62789186019, 77627.22372776257, 78017.60991195064, 78327.0, 9533.761655958519, 9663.27525435595, 9805.235057689542, 9932.0, 10009.349392289623, 13274.867251327363, 13324.866751332362, 13349.332533373292, 13358.532451364155, 13365.599032029055, 7846.646900889474, 7863.292303692695, 8114.066882308492, 8153.551554664432, 8305.750827475185, 8122.553259570662, 8184.713535026364, 8385.203405676451, 8408.2432581068, 8438.409311348269, 6108.725107370179, 6276.246850377984, 6300.8424789379715, 6328.145700330489, 6362.840928976812, 1702.3956495444186, 1702.455214331402, 1734.2889415339903, 1748.728947013215, 1765.920533575992, 977.6040703515088, 981.6466072213997, 989.1789814453986, 1030.5568605499557, 1056.1972900595604, 17979.370722024927, 18999.240030398905, 19098.33155839567, 19179.520511987314, 19340.32308869211, 992.5781542844262, 1008.8537162111453, 1018.5263852308564, 1041.7447725307347, 1049.9002594753485, 10643.254972151875, 10945.011720767669, 10967.396793176453, 10978.176636752276, 10979.39613321275, 469583.0, 478149.0, 482320.0, 484105.0, 485784.0, 80531.0, 81779.59110204411, 81809.0, 81965.18034819695, 82146.53560393197, 1018.9032041956151, 1021.7547788530848, 1064.5794911010262, 1079.881213066562, 1081.8564896446592, 16672.833271667612, 16834.326626934784, 16896.662066758843, 17031.0, 17318.480445586654, 35365.469517956735, 36213.45679814752, 36790.26419471649, 36940.0, 39126.0, 57651.42348576461, 57701.0, 58065.709671451375, 58930.70534647299, 60199.69900150471, 8039.758807235792, 8057.798555036171, 8121.8375632488205, 8140.83718325642, 8283.29591984664, 9095.090490950852, 11847.348395837967, 12856.742865142833, 12921.806172907225, 13080.869191308346, 10929.890701093205, 11376.601818936297, 11548.80572691186, 11671.241369310968, 12097.640960012714, 10841.837372439577, 11213.159013074215, 11240.943795280971, 11429.314241145557, 11472.713182170179, 10962.831257304546, 11555.88444115548, 11962.0, 12018.33899135556, 12069.456874440846, 8081.0, 8156.632951517077, 8271.966004249469, 8423.70517031901, 8488.787780305542, 8378.120297368689, 10655.25413221067, 11512.59705910289, 11609.941950290195, 11749.76500470003], "value": 9010.718960089524, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.4670131947225, 1487.761958086706, 1536.4161618584935, 1653.8428849259317, 1795.946121616351, 8198.42611017229, 8452.746417607474, 8491.787705307363, 8685.696000639962, 8790.208881200706, 8604.440711353758, 8768.824623507542, 8784.429012114208, 8791.0, 8809.86785198221, 2236.854604450714, 2261.016457840836, 2265.501589650274, 2266.1388672304583, 2268.0474200835606, 2238.7985081342676, 2286.4398222435525, 2288.553732022248, 2293.380787187467, 2296.0471404367167, 2245.764194759551, 2246.955060898781, 2253.9774602253933, 2270.795628393444, 2274.5678321118935, 2117.7246957895527, 2139.1336508713916, 2155.3426205007468, 2157.4390658428765, 2167.143978128638, 2180.160638154322, 2187.9124835006583, 2191.9890400548056, 2192.1450634252496, 2193.714817073786, 8483.278921291698, 8601.354898382646, 8610.095939926343, 8715.956420217859, 8964.68623598171, 5129.230615407681, 5242.580593552507, 5246.895062098775, 5248.7375631218665, 5248.9737551312, 3253.6420993690676, 3259.4621887388553, 3261.8858339957987, 3319.6348401675796, 3321.219513414346, 1018.9949050254776, 1031.1441503552035, 1055.5091882274703, 1064.4784055812675, 1065.0414626835832, 12691.11162218645, 12782.680432989157, 12831.550895718698, 12850.421731022034, 12856.807147892789, 4262.126264115849, 4288.957110428918, 4330.783460826946, 4347.760873152007, 4363.0, 9913.950430247802, 9966.40201587907, 9984.450855203033, 9988.200943924468, 9998.400095994264, 5037.29477873098, 5037.622178336566, 5045.722485263345, 5048.899022019613, 5053.84838454847, 4086.4074709167003, 4262.403263543107, 4743.644226683013, 4811.08589368019, 4847.854564363075, 3608.224231790178, 3621.27574485104, 3648.7993160376436, 3676.7793932364143, 3689.4834723138783, 1015.1016350529834, 1031.8855635913196, 1038.065740833256, 1039.8128336899279, 1060.1201003167353, 939.2955283537347, 986.3785814936688, 1004.3371374892536, 1016.8169729448622, 1022.9489872804978, 5934.554908381889, 6150.892839288881, 6164.7842325518395, 6216.813495595139, 6357.448250431043, 435.1319118358894, 435.37741030326936, 443.59411138807627, 452.27184233384224, 454.78170478170665, 4287.549807270254, 4328.091100868853, 4337.783110844445, 4352.39066530686, 4437.711548749321, 11087.113030957504, 11451.599194028335, 11507.482163302671, 11519.19365644397, 11536.134789890792, 11275.943620281847, 11373.715657108638, 11378.08975281992, 11378.601748938747, 11398.430078496041, 7982.680692772224, 8292.17078292178, 8308.584570771438, 8520.360972926932, 8529.402941794138, 5993.700314984146, 6268.435840774352, 6346.841328966812, 6356.98288273874, 6432.742690292524, 10239.7440063999, 10379.377237365481, 10537.42044187577, 10629.468526573486, 10674.199435042558, 10545.31455455393, 10700.732481688021, 10815.080718139046, 10823.134149267882, 10838.945805270923, 8056.234657707509, 8253.628586713732, 8265.0, 8267.049289331804, 8270.586470676562, 8486.19381158789, 8561.657533698582, 8663.870041949249, 8691.782705432415, 8788.296936244957, 7859.410544209093, 7884.29041386278, 7902.644381002754, 7941.523508589503, 8032.919670803217, 7686.846263074595, 7699.499532530368, 7783.299503044526, 7837.725679601187, 7983.081945576333, 7311.0, 7472.551646901204, 7478.2895624915545, 7484.588347640932, 7486.513376630502, 5092.872678183075, 5400.243965844864, 5492.258545096521, 5548.583856210881, 5606.18710286998, 5105.540501354896, 5117.667351622133, 5174.301469301747, 5333.946660533345, 5615.803446879339], "value": 4526.145058292112, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4652079735679, 297.98957036503725, 301.72995169323457, 302.5975452647978, 304.4307145637658, 5186.559142472895, 5197.116490196666, 5209.124715102565, 5217.608679349045, 5228.73856307185, 5164.096283150452, 5167.586593072555, 5168.113638521941, 5184.196449550316, 5189.014087323406, 3884.495015647969, 3924.9803750981205, 4002.2195671844, 4019.8995025124314, 4034.7780872052026, 4032.3749818777987, 4032.6087499812515, 4041.3533834586474, 4054.2904991626497, 4055.2700513907484, 3854.402567602026, 4006.0786019215598, 4021.0, 4023.9678962124085, 4024.5170579530495, 3741.7754934704003, 3957.4474463970723, 3994.8202330895033, 4030.294698427793, 4055.959440405588, 3514.876979305712, 3515.789052656849, 3545.2200515886466, 3545.5745310562897, 3548.982255088734, 5013.473585273567, 5048.747562621891, 5058.052649729843, 5085.771140298659, 5097.490250974873, 4499.0, 4577.885552861205, 4587.128445595359, 4591.95408045922, 4594.437891117036, 5317.175837745156, 5354.7416357156035, 5372.194170874361, 5381.354237491526, 5401.810936617199, 3857.209272099241, 3871.2838124946693, 3877.6316249956208, 3901.0, 3901.941470877939, 5368.91946620801, 5592.098686446587, 5635.6055076144685, 5654.717264136818, 5704.0, 3890.8638197662945, 3908.5895980922164, 3908.8241029153755, 3926.155876486569, 3936.527616685959, 3941.172353805733, 3993.6805055595482, 3995.2409042281874, 4002.3196056670436, 4027.4764280643913, 4304.763238021939, 4550.453945526492, 4595.310703394518, 4608.28571571407, 4632.72203667781, 5500.257465242221, 5500.367457742411, 5501.449855014466, 5502.532284755841, 5508.209831804679, 1341.3025226882162, 1343.8320209973754, 1350.4058214385639, 1355.8372995240436, 1365.7951307303983, 823.81052357958, 855.7676945198893, 858.2318824651902, 869.096140014378, 871.9215270625674, 5105.489451054865, 5174.197999310113, 5188.662736922088, 5197.610179236573, 5262.236975638511, 5528.115501519737, 5558.360788509292, 5575.303087114111, 5579.832605021856, 5609.0, 4999.42506611737, 5206.167013277857, 5209.791608335624, 5215.713135777569, 5256.947430525723, 2953.2469220349103, 2964.570137330118, 2965.5996440480258, 2975.152081656761, 2987.970120298769, 5749.1663708762, 5786.2477877876445, 5786.479216870502, 5789.363170051291, 5804.593678442553, 5486.753096110685, 5725.856853578611, 5819.679917604572, 5828.679422631796, 5831.504322132666, 5800.4489573490455, 5804.24298458229, 5829.650220986754, 5858.765649373977, 5868.413158684012, 5537.1140617501005, 5657.179708942098, 5683.5737319700365, 5703.089465029262, 5704.80033198836, 5563.358809151391, 5574.275344205227, 5575.721213939206, 5591.580631452576, 5603.80386686464, 5752.28096487939, 5760.654360738369, 5765.7117144141785, 5779.682117483579, 5828.213191219301, 3731.067233191702, 3781.4138808484727, 3797.050737315671, 3804.524434445694, 3826.2730081284467, 5601.831945041656, 5630.0991841305195, 5644.0, 5645.379008309164, 5645.71771411436, 5507.9449205507435, 5508.76052888097, 5511.586631002771, 5514.944850551443, 5519.365272993497, 5374.973125134349, 5463.453654634504, 5477.178423236546, 5500.312460942382, 5503.2114562766465, 5163.638545301793, 5378.354597448331, 5384.407715151408, 5387.703676297841, 5399.919001215064, 5298.44366341544, 5399.622026458111, 5421.241026256406, 5426.186072089218, 5465.781368745205, 5325.295905310263, 5329.946700532945, 5370.0, 5379.67721936685, 5387.81142660005], "value": 4120.769189978628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.8719099775545, 674.5278305186371, 731.2212493694216, 798.5089170160352, 809.5466538738307, 14737.0, 15309.846901530982, 15830.60423489412, 15849.445269415573, 15885.920570397146, 14317.92841035796, 14366.281685915716, 14387.208703521303, 14390.1365918045, 14407.135571865669, 664.5215444879703, 778.3111945927866, 792.2869417524231, 804.3082948664144, 813.6257321632056, 784.3803395317692, 789.8736202207648, 790.4348390900504, 791.8060075281535, 791.8970533830594, 835.6657337065162, 838.9538575378351, 839.492107275099, 839.937004724645, 839.9790005249856, 685.5783693028776, 816.5508970066439, 833.7707130539089, 834.8914641096679, 845.0366582096415, 613.1385403508078, 616.1774031667729, 616.1804799616499, 617.450469082517, 617.6355949989482, 13927.930360348235, 14019.789703154358, 14052.227127507984, 14069.366878490493, 14076.296185190802, 12563.560275390317, 13090.672733181651, 13307.667308317272, 13441.395137218751, 13854.376553055137, 11382.658520244324, 11518.942405288004, 11789.705257368549, 12093.45579448927, 12167.330796806173, 4282.462865356963, 4311.504177019651, 4337.4116664844305, 4356.455443069616, 4383.780810959471, 69646.303536965, 70142.29857701408, 70333.0, 70529.64735176343, 70648.29351706468, 9986.300958932805, 9999.650012249682, 10027.749306267257, 10217.795644087226, 10423.583056677648, 19629.901850490656, 19723.605527889362, 19753.60492790136, 19767.505812354808, 19935.20259189645, 7282.781516554512, 7637.923620763832, 7766.417518686008, 7828.060632723996, 7938.801529961797, 4105.609967053185, 4122.56713045126, 4189.748615083105, 4220.261454245495, 4317.740935543878, 3378.5438965739804, 3482.721382289411, 3498.8775392861126, 3533.4876442915634, 3535.6641119093647, 591.0189086117111, 597.7130977131002, 599.4784537452445, 602.3976023976024, 606.7633622887078, 558.1404636859272, 572.4275724275724, 630.2090875950653, 648.9578177418452, 665.434380776346, 7931.682732690743, 8173.305269052197, 8652.567371631394, 8731.013036718035, 9055.637774489078, 570.0195663458844, 636.818506725581, 638.6742761191733, 675.7263308360122, 678.4320900356531, 4539.795709193094, 4564.817407303671, 4641.535846415331, 4671.789769460383, 4715.4577223619035, 111696.0, 113418.3290835455, 114623.0, 114989.4250528742, 116966.0, 63174.0, 85365.57317213374, 88377.55811220902, 92148.53925730463, 95442.52278738562, 81740.59129704432, 82468.58765706253, 83491.58254208691, 85324.0, 85436.99999999876, 8741.91258087411, 8759.824803504021, 8898.644054237759, 9071.863922041042, 9088.681896133603, 44005.0, 45851.3122303159, 50602.49397505978, 51636.48363516317, 52300.21549676682, 71962.0, 72193.27806721865, 73431.63284183545, 74604.25395745973, 75072.62463687647, 11934.820977685515, 12002.1598488105, 12028.0, 12503.437345319664, 12758.425870835648, 13473.595792126252, 13588.0, 13953.441862325393, 14171.433142674177, 14270.143791372551, 12424.689382765504, 13378.464861405435, 13425.798613020617, 13449.86550134486, 13510.662233444242, 13417.396217170446, 13464.0, 13935.163890166623, 14238.35927383291, 14383.856161438252, 12744.553940612033, 12851.421686023965, 12877.425109640899, 12918.870811291767, 12946.417411216706, 10813.567457301935, 10942.945285273523, 11092.667219983414, 11180.664580062612, 11391.829122563002, 11034.448277586249, 11049.668509944715, 11107.38909359993, 11180.608678696206, 11223.71940701489], "value": 7205.574012401087, "unit": "score"}], "name": "dromaeo_css", "value": 7050.501496274293, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 111.0, 110.0, 111.0, 110.0, 111.0, 109.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 126.0, 184.0, 126.0, 132.0, 161.0, 126.0, 160.0, 133.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 123.0, 77.0, 76.0, 75.0, 75.0, 108.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 109.0, 86.0, 92.0, 86.0, 115.0, 85.0, 85.0, 129.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 53.0, 55.0, 54.0, 53.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 80.0, 81.0, 80.0, 81.0, 80.0, 85.0, 108.0, 81.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 126.0, 133.0, 127.0, 120.0, 132.0, 142.0, 137.0, 122.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 159.0, 159.0, 161.0, 162.0, 160.0, 160.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 63.0, 63.0, 67.0, 63.0, 62.0, 64.0, 62.0, 62.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1504.5999999999997, "alertThreshold": 2.0}]} 08:25:34 INFO - Return code: 0 08:25:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:34 ERROR - # TBPL SUCCESS # 08:25:34 INFO - Running post-action listener: _resource_record_post_action 08:25:34 INFO - ##### 08:25:34 INFO - ##### Finished run-tests step (success) 08:25:34 INFO - ##### 08:25:34 INFO - Running post-run listener: _resource_record_post_run 08:25:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547790848; Read time: 12; Write time: 627008 08:25:34 INFO - TinderboxPrint: CPU usage
13.1% 08:25:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:25:34 INFO - TinderboxPrint: I/O write bytes / time
547,790,848 / 627,008 08:25:34 INFO - TinderboxPrint: CPU idle
8,263.6 (86.9%) 08:25:34 INFO - TinderboxPrint: CPU user
1,204.2 (12.7%) 08:25:34 INFO - TinderboxPrint: Swap in / out
0 / 0 08:25:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259399680; Read time: 0; Write time: 346736 08:25:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288391168; Read time: 12; Write time: 280272 08:25:34 INFO - Running post-run listener: _upload_blobber_files 08:25:34 INFO - Blob upload gear active. 08:25:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:34 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 08:25:34 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'] 08:25:34 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 08:25:35 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:36 INFO - (blobuploader) - INFO - Done attempting. 08:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:36 INFO - (blobuploader) - INFO - Done attempting. 08:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:40 INFO - (blobuploader) - INFO - Done attempting. 08:25:40 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:40 INFO - Return code: 0 08:25:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4677572519d525b72e42f5ccd3c98867f69029750ee1b0e765c34b4b23035fbfc6256c419c7cfb22d6455d5b2aae87930c2367b9b7d573566893d9673e54271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1bca3828c63a357775eb6e650a29ba324a26047230ffe019eb356c75621452f346be509ec0b54fd8d24b091b40f122172ba6f81c238fe1144611addfbdf55b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a402fb2aa3affb99e2b1b719dc94f429373d9e638b5ad449609e018d177042c94372a6ec1b3dbcb85d8fdb837d9c696474053480b186e9a83c5f89f8558f58e"} 08:25:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:40 INFO - Contents: 08:25:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f4677572519d525b72e42f5ccd3c98867f69029750ee1b0e765c34b4b23035fbfc6256c419c7cfb22d6455d5b2aae87930c2367b9b7d573566893d9673e54271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1bca3828c63a357775eb6e650a29ba324a26047230ffe019eb356c75621452f346be509ec0b54fd8d24b091b40f122172ba6f81c238fe1144611addfbdf55b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a402fb2aa3affb99e2b1b719dc94f429373d9e638b5ad449609e018d177042c94372a6ec1b3dbcb85d8fdb837d9c696474053480b186e9a83c5f89f8558f58e"} 08:25:40 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:40 INFO - Copying logs to upload dir... 08:25:40 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.233489 ========= master_lag: -0.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-07 08:25:38.696115) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:25:38.699854) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086 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/f4677572519d525b72e42f5ccd3c98867f69029750ee1b0e765c34b4b23035fbfc6256c419c7cfb22d6455d5b2aae87930c2367b9b7d573566893d9673e54271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1bca3828c63a357775eb6e650a29ba324a26047230ffe019eb356c75621452f346be509ec0b54fd8d24b091b40f122172ba6f81c238fe1144611addfbdf55b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a402fb2aa3affb99e2b1b719dc94f429373d9e638b5ad449609e018d177042c94372a6ec1b3dbcb85d8fdb837d9c696474053480b186e9a83c5f89f8558f58e"} build_url:https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/TTowXjKsSnuxD_35ykwEQg/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/f4677572519d525b72e42f5ccd3c98867f69029750ee1b0e765c34b4b23035fbfc6256c419c7cfb22d6455d5b2aae87930c2367b9b7d573566893d9673e54271", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1bca3828c63a357775eb6e650a29ba324a26047230ffe019eb356c75621452f346be509ec0b54fd8d24b091b40f122172ba6f81c238fe1144611addfbdf55b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1a402fb2aa3affb99e2b1b719dc94f429373d9e638b5ad449609e018d177042c94372a6ec1b3dbcb85d8fdb837d9c696474053480b186e9a83c5f89f8558f58e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 08:25:38.728965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:25:38.729676) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465311903.473227-2113665086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 08:25:38.813547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:25:38.814144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 08:25:38.814728) ========= ========= Total master_lag: -0.19 =========