builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1470004436.77 results: success (0) buildid: 20160731124125 builduid: 5c8365d92e7c4b409d9e20a793f2e5f3 revision: 1a408f5eb42e99435820445547affab4e21df92e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:56.768247) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:56.768720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:56.769044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:56.817289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:56.817615) ========= 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=00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-31 15:33:57-- 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% 102M=0s 2016-07-31 15:33:57 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126325 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:56.965546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:56.965932) ========= 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=00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018825 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:57.022689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:57.023073) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a408f5eb42e99435820445547affab4e21df92e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a408f5eb42e99435820445547affab4e21df92e --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=00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-31 15:33:57,370 truncating revision to first 12 chars 2016-07-31 15:33:57,370 Setting DEBUG logging. 2016-07-31 15:33:57,370 attempt 1/10 2016-07-31 15:33:57,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a408f5eb42e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 15:33:57,834 unpacking tar archive at: mozilla-aurora-1a408f5eb42e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.801894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:57.840087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:57.840453) ========= script_repo_revision: 1a408f5eb42e99435820445547affab4e21df92e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:57.840892) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:57.841207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 15:33:57.850814) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-31 15:33:57.851132) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:33:58 INFO - MultiFileLogger online at 20160731 15:33:58 in /builds/slave/test 15:33:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:33:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:33:58 INFO - {'append_to_log': False, 15:33:58 INFO - 'base_work_dir': '/builds/slave/test', 15:33:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:33:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:33:58 INFO - 'branch': 'Mozilla-Aurora', 15:33:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:33:58 INFO - 'config_files': ('talos/linux_config.py',), 15:33:58 INFO - 'default_actions': ('clobber', 15:33:58 INFO - 'read-buildbot-config', 15:33:58 INFO - 'download-and-extract', 15:33:58 INFO - 'populate-webroot', 15:33:58 INFO - 'create-virtualenv', 15:33:58 INFO - 'install', 15:33:58 INFO - 'run-tests'), 15:33:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:33:58 INFO - 'download_minidump_stackwalk': True, 15:33:58 INFO - 'download_symbols': 'ondemand', 15:33:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:33:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:33:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:33:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:33:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:33:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:33:58 INFO - 'installer_path': 'installer.exe', 15:33:58 INFO - 'log_level': 'info', 15:33:58 INFO - 'log_name': 'talos', 15:33:58 INFO - 'log_to_console': True, 15:33:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:33:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:33:58 INFO - 'opt_config_files': (), 15:33:58 INFO - 'pip_index': False, 15:33:58 INFO - 'sps_profile': False, 15:33:58 INFO - 'sps_profile_interval': 0, 15:33:58 INFO - 'suite': 'dromaeojs-e10s', 15:33:58 INFO - 'system_bits': '32', 15:33:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:33:58 INFO - 'title': 'talos-linux64-ix-016', 15:33:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:33:58 INFO - 'use_talos_json': True, 15:33:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:33:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:33:58 INFO - 'work_dir': 'build'} 15:33:58 INFO - ##### 15:33:58 INFO - ##### Running clobber step. 15:33:58 INFO - ##### 15:33:58 INFO - Running pre-action listener: _resource_record_pre_action 15:33:58 INFO - Running main action method: clobber 15:33:58 INFO - rmtree: /builds/slave/test/build 15:33:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:33:58 INFO - Running post-action listener: _resource_record_post_action 15:33:58 INFO - ##### 15:33:58 INFO - ##### Finished clobber step (success) 15:33:58 INFO - ##### 15:33:58 INFO - ##### 15:33:58 INFO - ##### Running read-buildbot-config step. 15:33:58 INFO - ##### 15:33:58 INFO - Running pre-action listener: _resource_record_pre_action 15:33:58 INFO - Running main action method: read_buildbot_config 15:33:58 INFO - Using buildbot properties: 15:33:58 INFO - { 15:33:58 INFO - "project": "", 15:33:58 INFO - "product": "firefox", 15:33:58 INFO - "script_repo_revision": "production", 15:33:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:33:58 INFO - "repository": "", 15:33:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:33:58 INFO - "buildid": "20160731124125", 15:33:58 INFO - "pgo_build": "True", 15:33:58 INFO - "basedir": "/builds/slave/test", 15:33:58 INFO - "buildnumber": 483, 15:33:58 INFO - "slavename": "talos-linux64-ix-016", 15:33:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:33:58 INFO - "platform": "ubuntu64_hw", 15:33:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:33:58 INFO - "branch": "mozilla-aurora", 15:33:58 INFO - "repo_path": "releases/mozilla-aurora", 15:33:58 INFO - "revision": "1a408f5eb42e99435820445547affab4e21df92e", 15:33:58 INFO - "stage_platform": "linux64-pgo", 15:33:58 INFO - "builduid": "5c8365d92e7c4b409d9e20a793f2e5f3", 15:33:58 INFO - "slavebuilddir": "test" 15:33:58 INFO - } 15:33:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:33:58 INFO - Running post-action listener: _resource_record_post_action 15:33:58 INFO - ##### 15:33:58 INFO - ##### Finished read-buildbot-config step (success) 15:33:58 INFO - ##### 15:33:58 INFO - ##### 15:33:58 INFO - ##### Running download-and-extract step. 15:33:58 INFO - ##### 15:33:58 INFO - Running pre-action listener: _resource_record_pre_action 15:33:58 INFO - Running main action method: download_and_extract 15:33:58 INFO - mkdir: /builds/slave/test/build/tests 15:33:58 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')]} 15:33:58 INFO - https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:33:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:33:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:33:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:34:01 INFO - Downloaded 1361 bytes. 15:34:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:34:01 INFO - Using the following test package requirements: 15:34:01 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:34:01 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:34:01 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:34:01 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'jsshell-linux-x86_64.zip'], 15:34:01 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:34:01 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:34:01 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:34:01 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:34:01 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:34:01 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:34:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:34:01 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:01 INFO - https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:34:02 INFO - Downloaded 21971074 bytes. 15:34:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:34:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:34:03 INFO - Return code: 0 15:34:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:34:03 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')]} 15:34:03 INFO - https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:34:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:34:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:34:10 INFO - Downloaded 21971074 bytes. 15:34:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:34:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:34:11 INFO - Return code: 0 15:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:11 INFO - https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:34:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:34:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:34:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:34:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:34:12 INFO - Downloaded 10833369 bytes. 15:34:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:34:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:34:12 INFO - Return code: 0 15:34: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')]} 15:34:12 INFO - https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:34:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:34:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:34:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:34:14 INFO - Downloaded 61975356 bytes. 15:34:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:34:14 INFO - mkdir: /builds/slave/test/properties 15:34:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:14 INFO - Contents: 15:34:14 INFO - build_url:https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:34:15 INFO - Running post-action listener: _resource_record_post_action 15:34:15 INFO - Running post-action listener: set_extra_try_arguments 15:34:15 INFO - ##### 15:34:15 INFO - ##### Finished download-and-extract step (success) 15:34:15 INFO - ##### 15:34:15 INFO - ##### 15:34:15 INFO - ##### Running populate-webroot step. 15:34:15 INFO - ##### 15:34:15 INFO - Running pre-action listener: _resource_record_pre_action 15:34:15 INFO - Running main action method: populate_webroot 15:34:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:34:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:34:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:34:15 INFO - '--tppagecycles', 15:34:15 INFO - '7'], 15:34:15 INFO - 'tests': ['tsvgm']}}, 15:34:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:34:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:34:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:34:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:34:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['damp', 'tps']}, 15:34:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'tests': ['damp', 'tps']}, 15:34:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['dromaeo_dom']}, 15:34:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['a11yr', 15:34:15 INFO - 'ts_paint', 15:34:15 INFO - 'tpaint', 15:34:15 INFO - 'sessionrestore', 15:34:15 INFO - 'sessionrestore_no_auto_restore', 15:34:15 INFO - 'tabpaint']}, 15:34:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:34:15 INFO - 'ts_paint', 15:34:15 INFO - 'tpaint', 15:34:15 INFO - 'sessionrestore', 15:34:15 INFO - 'sessionrestore_no_auto_restore', 15:34:15 INFO - 'tabpaint']}, 15:34:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:34:15 INFO - 'ts_paint', 15:34:15 INFO - 'tpaint', 15:34:15 INFO - 'sessionrestore', 15:34:15 INFO - 'sessionrestore_no_auto_restore', 15:34:15 INFO - 'tabpaint']}, 15:34:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:34:15 INFO - 'ts_paint', 15:34:15 INFO - 'tpaint', 15:34:15 INFO - 'sessionrestore', 15:34:15 INFO - 'sessionrestore_no_auto_restore', 15:34:15 INFO - 'tabpaint']}, 15:34:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['a11yr', 15:34:15 INFO - 'ts_paint', 15:34:15 INFO - 'tpaint', 15:34:15 INFO - 'sessionrestore', 15:34:15 INFO - 'sessionrestore_no_auto_restore', 15:34:15 INFO - 'tabpaint']}, 15:34:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['a11yr', 15:34:15 INFO - 'ts_paint', 15:34:15 INFO - 'tpaint', 15:34:15 INFO - 'sessionrestore', 15:34:15 INFO - 'sessionrestore_no_auto_restore', 15:34:15 INFO - 'tabpaint']}, 15:34:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['tsvgx', 15:34:15 INFO - 'tsvgr_opacity', 15:34:15 INFO - 'tart', 15:34:15 INFO - 'tscrollx', 15:34:15 INFO - 'cart']}, 15:34:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:34:15 INFO - 'tsvgr_opacity', 15:34:15 INFO - 'tart', 15:34:15 INFO - 'tscrollx', 15:34:15 INFO - 'cart']}, 15:34:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'talos_options': ['--disable-e10s'], 15:34:15 INFO - 'tests': ['tp5o']}, 15:34:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'tests': ['tp5o']}, 15:34:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'talos_options': ['--disable-e10s', 15:34:15 INFO - '--xperf_path', 15:34:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:15 INFO - 'tests': ['tp5n']}, 15:34:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:15 INFO - 'talos_options': ['--xperf_path', 15:34:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:15 INFO - 'tests': ['tp5n']}}, 15:34:15 INFO - 'talos.zip': {'path': '', 15:34:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:34:15 INFO - Running post-action listener: _resource_record_post_action 15:34:15 INFO - ##### 15:34:15 INFO - ##### Finished populate-webroot step (success) 15:34:15 INFO - ##### 15:34:15 INFO - ##### 15:34:15 INFO - ##### Running create-virtualenv step. 15:34:15 INFO - ##### 15:34:15 INFO - Running pre-action listener: _resource_record_pre_action 15:34:15 INFO - Running main action method: create_virtualenv 15:34:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:15 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 15:34:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:15 INFO - Using real prefix '/usr' 15:34:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:15 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:17 INFO - Installing pip.................done. 15:34:17 INFO - Return code: 0 15:34:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:17 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 15:34:17 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 15:34:17 INFO - Using env: {'DISPLAY': ':0', 15:34:17 INFO - 'HOME': '/home/cltbld', 15:34:17 INFO - 'LANG': 'en_US.UTF-8', 15:34:17 INFO - 'LANGUAGE': 'en_US:en', 15:34:17 INFO - 'LOGNAME': 'cltbld', 15:34:17 INFO - 'MAIL': '/var/mail/cltbld', 15:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:17 INFO - 'MOZ_NO_REMOTE': '1', 15:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:17 INFO - 'NO_EM_RESTART': '1', 15:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:17 INFO - 'PWD': '/builds/slave/test', 15:34:17 INFO - 'SHELL': '/bin/bash', 15:34:17 INFO - 'SHLVL': '1', 15:34:17 INFO - 'TERM': 'linux', 15:34:17 INFO - 'TMOUT': '86400', 15:34:17 INFO - 'USER': 'cltbld', 15:34:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:17 INFO - '_': '/tools/buildbot/bin/python'} 15:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:17 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 15:34:17 INFO - Cleaning up... 15:34:17 INFO - Return code: 0 15:34:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:17 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:17 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 15:34:17 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 15:34:17 INFO - Using env: {'DISPLAY': ':0', 15:34:17 INFO - 'HOME': '/home/cltbld', 15:34:17 INFO - 'LANG': 'en_US.UTF-8', 15:34:17 INFO - 'LANGUAGE': 'en_US:en', 15:34:17 INFO - 'LOGNAME': 'cltbld', 15:34:17 INFO - 'MAIL': '/var/mail/cltbld', 15:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:17 INFO - 'MOZ_NO_REMOTE': '1', 15:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:17 INFO - 'NO_EM_RESTART': '1', 15:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:17 INFO - 'PWD': '/builds/slave/test', 15:34:17 INFO - 'SHELL': '/bin/bash', 15:34:17 INFO - 'SHLVL': '1', 15:34:17 INFO - 'TERM': 'linux', 15:34:17 INFO - 'TMOUT': '86400', 15:34:17 INFO - 'USER': 'cltbld', 15:34:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:17 INFO - '_': '/tools/buildbot/bin/python'} 15:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:18 INFO - Downloading/unpacking psutil>=3.1.1 15:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:20 INFO - Installing collected packages: psutil 15:34:20 INFO - Running setup.py install for psutil 15:34:20 INFO - building 'psutil._psutil_linux' extension 15:34:20 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 15:34:20 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 15:34:20 INFO - building 'psutil._psutil_posix' extension 15:34:20 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 15:34:20 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 15:34:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:20 INFO - Successfully installed psutil 15:34:20 INFO - Cleaning up... 15:34:20 INFO - Return code: 0 15:34:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:34: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 mozsystemmonitor==0.3 15:34:20 INFO - Using env: {'DISPLAY': ':0', 15:34:20 INFO - 'HOME': '/home/cltbld', 15:34:20 INFO - 'LANG': 'en_US.UTF-8', 15:34:20 INFO - 'LANGUAGE': 'en_US:en', 15:34:20 INFO - 'LOGNAME': 'cltbld', 15:34:20 INFO - 'MAIL': '/var/mail/cltbld', 15:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:20 INFO - 'MOZ_NO_REMOTE': '1', 15:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:20 INFO - 'NO_EM_RESTART': '1', 15:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:20 INFO - 'PWD': '/builds/slave/test', 15:34:20 INFO - 'SHELL': '/bin/bash', 15:34:20 INFO - 'SHLVL': '1', 15:34:20 INFO - 'TERM': 'linux', 15:34:20 INFO - 'TMOUT': '86400', 15:34:20 INFO - 'USER': 'cltbld', 15:34:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:20 INFO - '_': '/tools/buildbot/bin/python'} 15:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:34:22 INFO - Installing collected packages: mozsystemmonitor 15:34:22 INFO - Running setup.py install for mozsystemmonitor 15:34:22 INFO - Successfully installed mozsystemmonitor 15:34:22 INFO - Cleaning up... 15:34:22 INFO - Return code: 0 15:34:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:34:22 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')]} 15:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:22 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')]} 15:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:22 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:22 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 15:34:22 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 15:34:22 INFO - Using env: {'DISPLAY': ':0', 15:34:22 INFO - 'HOME': '/home/cltbld', 15:34:22 INFO - 'LANG': 'en_US.UTF-8', 15:34:22 INFO - 'LANGUAGE': 'en_US:en', 15:34:22 INFO - 'LOGNAME': 'cltbld', 15:34:22 INFO - 'MAIL': '/var/mail/cltbld', 15:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:22 INFO - 'MOZ_NO_REMOTE': '1', 15:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:22 INFO - 'NO_EM_RESTART': '1', 15:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:22 INFO - 'PWD': '/builds/slave/test', 15:34:22 INFO - 'SHELL': '/bin/bash', 15:34:22 INFO - 'SHLVL': '1', 15:34:22 INFO - 'TERM': 'linux', 15:34:22 INFO - 'TMOUT': '86400', 15:34:22 INFO - 'USER': 'cltbld', 15:34:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:22 INFO - '_': '/tools/buildbot/bin/python'} 15:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:23 INFO - Downloading/unpacking jsonschema==2.5.1 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:34:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:25 INFO - Downloading functools32-3.2.3-2.tar.gz 15:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:34:25 INFO - warning: no files found matching '*.txt' 15:34:25 INFO - no previously-included directories found matching 'build' 15:34:25 INFO - no previously-included directories found matching 'dist' 15:34:25 INFO - no previously-included directories found matching '.git*' 15:34:25 INFO - Installing collected packages: jsonschema, functools32 15:34:25 INFO - Running setup.py install for functools32 15:34:25 INFO - warning: no files found matching '*.txt' 15:34:25 INFO - no previously-included directories found matching 'build' 15:34:25 INFO - no previously-included directories found matching 'dist' 15:34:25 INFO - no previously-included directories found matching '.git*' 15:34:25 INFO - Successfully installed jsonschema functools32 15:34:25 INFO - Cleaning up... 15:34:25 INFO - Return code: 0 15:34:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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', '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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:34: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 blobuploader==1.2.4 15:34:25 INFO - Using env: {'DISPLAY': ':0', 15:34:25 INFO - 'HOME': '/home/cltbld', 15:34:25 INFO - 'LANG': 'en_US.UTF-8', 15:34:25 INFO - 'LANGUAGE': 'en_US:en', 15:34:25 INFO - 'LOGNAME': 'cltbld', 15:34:25 INFO - 'MAIL': '/var/mail/cltbld', 15:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:25 INFO - 'MOZ_NO_REMOTE': '1', 15:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:25 INFO - 'NO_EM_RESTART': '1', 15:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:25 INFO - 'PWD': '/builds/slave/test', 15:34:25 INFO - 'SHELL': '/bin/bash', 15:34:25 INFO - 'SHLVL': '1', 15:34:25 INFO - 'TERM': 'linux', 15:34:25 INFO - 'TMOUT': '86400', 15:34:25 INFO - 'USER': 'cltbld', 15:34:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:25 INFO - '_': '/tools/buildbot/bin/python'} 15:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:25 INFO - Downloading/unpacking blobuploader==1.2.4 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:27 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:28 INFO - Downloading docopt-0.6.1.tar.gz 15:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:28 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:28 INFO - Running setup.py install for blobuploader 15:34:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:28 INFO - Running setup.py install for requests 15:34:28 INFO - Running setup.py install for docopt 15:34:28 INFO - Successfully installed blobuploader requests docopt 15:34:28 INFO - Cleaning up... 15:34:28 INFO - Return code: 0 15:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:28 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')]} 15:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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')]} 15:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:28 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 15:34:28 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 15:34:28 INFO - Using env: {'DISPLAY': ':0', 15:34:28 INFO - 'HOME': '/home/cltbld', 15:34:28 INFO - 'LANG': 'en_US.UTF-8', 15:34:28 INFO - 'LANGUAGE': 'en_US:en', 15:34:28 INFO - 'LOGNAME': 'cltbld', 15:34:28 INFO - 'MAIL': '/var/mail/cltbld', 15:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:28 INFO - 'MOZ_NO_REMOTE': '1', 15:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:28 INFO - 'NO_EM_RESTART': '1', 15:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:28 INFO - 'PWD': '/builds/slave/test', 15:34:28 INFO - 'SHELL': '/bin/bash', 15:34:28 INFO - 'SHLVL': '1', 15:34:28 INFO - 'TERM': 'linux', 15:34:28 INFO - 'TMOUT': '86400', 15:34:28 INFO - 'USER': 'cltbld', 15:34:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:28 INFO - '_': '/tools/buildbot/bin/python'} 15:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:29 INFO - Running setup.py (path:/tmp/pip-lM7YbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:29 INFO - Running setup.py (path:/tmp/pip-xuVnHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:29 INFO - Running setup.py (path:/tmp/pip-_YE5At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:29 INFO - Running setup.py (path:/tmp/pip-Vspkw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:29 INFO - Running setup.py (path:/tmp/pip-_N8tj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:29 INFO - Running setup.py (path:/tmp/pip-6Ei4S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:29 INFO - Running setup.py (path:/tmp/pip-IP9S6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:29 INFO - Running setup.py (path:/tmp/pip-A1G2nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:29 INFO - Running setup.py (path:/tmp/pip-gVChW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:29 INFO - Running setup.py (path:/tmp/pip-1BdDCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:29 INFO - Running setup.py (path:/tmp/pip-qArJG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:29 INFO - Running setup.py (path:/tmp/pip-3ZyiOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:30 INFO - Running setup.py (path:/tmp/pip-UyAqh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:30 INFO - Running setup.py (path:/tmp/pip-O1sryj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:30 INFO - Running setup.py (path:/tmp/pip-NY5_li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:30 INFO - Running setup.py (path:/tmp/pip-bgyDAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:30 INFO - Running setup.py (path:/tmp/pip-TLc3Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:30 INFO - Running setup.py install for manifestparser 15:34:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:30 INFO - Running setup.py install for mozcrash 15:34:30 INFO - Running setup.py install for mozdebug 15:34:30 INFO - Running setup.py install for mozdevice 15:34:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:34:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:30 INFO - Running setup.py install for mozfile 15:34:30 INFO - Running setup.py install for mozhttpd 15:34:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozinfo 15:34:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozInstall 15:34:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozleak 15:34:31 INFO - Running setup.py install for mozlog 15:34:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for moznetwork 15:34:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozprocess 15:34:31 INFO - Running setup.py install for mozprofile 15:34:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozrunner 15:34:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:31 INFO - Running setup.py install for mozscreenshot 15:34:31 INFO - Running setup.py install for moztest 15:34:32 INFO - Running setup.py install for mozversion 15:34:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:32 INFO - Cleaning up... 15:34:32 INFO - Return code: 0 15:34:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:32 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:32 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 15:34:32 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 15:34:32 INFO - Using env: {'DISPLAY': ':0', 15:34:32 INFO - 'HOME': '/home/cltbld', 15:34:32 INFO - 'LANG': 'en_US.UTF-8', 15:34:32 INFO - 'LANGUAGE': 'en_US:en', 15:34:32 INFO - 'LOGNAME': 'cltbld', 15:34:32 INFO - 'MAIL': '/var/mail/cltbld', 15:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:32 INFO - 'MOZ_NO_REMOTE': '1', 15:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:32 INFO - 'NO_EM_RESTART': '1', 15:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:32 INFO - 'PWD': '/builds/slave/test', 15:34:32 INFO - 'SHELL': '/bin/bash', 15:34:32 INFO - 'SHLVL': '1', 15:34:32 INFO - 'TERM': 'linux', 15:34:32 INFO - 'TMOUT': '86400', 15:34:32 INFO - 'USER': 'cltbld', 15:34:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:32 INFO - '_': '/tools/buildbot/bin/python'} 15:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:32 INFO - Running setup.py (path:/tmp/pip-O4Zl02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:32 INFO - Running setup.py (path:/tmp/pip-3ujSLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:32 INFO - Running setup.py (path:/tmp/pip-3Dw1WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:32 INFO - Running setup.py (path:/tmp/pip-CfQ_06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:32 INFO - Running setup.py (path:/tmp/pip-U67kCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:32 INFO - Running setup.py (path:/tmp/pip-jHuR94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:32 INFO - Running setup.py (path:/tmp/pip-45oSpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:32 INFO - Running setup.py (path:/tmp/pip-Y4QSgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:32 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)) 15:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:32 INFO - Running setup.py (path:/tmp/pip-Q_NqJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:33 INFO - Running setup.py (path:/tmp/pip-VgNGup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:33 INFO - Running setup.py (path:/tmp/pip-gF1C7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:33 INFO - Running setup.py (path:/tmp/pip-SnBFSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:33 INFO - Running setup.py (path:/tmp/pip-d_vYLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:33 INFO - Running setup.py (path:/tmp/pip-TqMJqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:33 INFO - Running setup.py (path:/tmp/pip-dHQcfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:33 INFO - Running setup.py (path:/tmp/pip-0_Xmgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:33 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)) 15:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:33 INFO - Running setup.py (path:/tmp/pip-0NVcaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:33 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)) 15:34:33 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)) 15:34:33 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)) 15:34:33 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)) 15:34:33 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)) 15:34:33 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)) 15:34:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:33 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 15:34:33 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 15:34:33 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 15:34:33 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 15:34:33 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 15:34:33 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 15:34:35 INFO - Downloading blessings-1.6.tar.gz 15:34:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:35 INFO - Installing collected packages: blessings 15:34:35 INFO - Running setup.py install for blessings 15:34:35 INFO - Successfully installed blessings 15:34:35 INFO - Cleaning up... 15:34:35 INFO - Return code: 0 15:34:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:36 INFO - Reading from file tmpfile_stdout 15:34:36 INFO - Current package versions: 15:34:36 INFO - argparse == 1.2.1 15:34:36 INFO - blessings == 1.6 15:34:36 INFO - blobuploader == 1.2.4 15:34:36 INFO - docopt == 0.6.1 15:34:36 INFO - functools32 == 3.2.3-2 15:34:36 INFO - jsonschema == 2.5.1 15:34:36 INFO - manifestparser == 1.1 15:34:36 INFO - mozInstall == 1.12 15:34:36 INFO - mozcrash == 0.17 15:34:36 INFO - mozdebug == 0.1 15:34:36 INFO - mozdevice == 0.48 15:34:36 INFO - mozfile == 1.2 15:34:36 INFO - mozhttpd == 0.7 15:34:36 INFO - mozinfo == 0.9 15:34:36 INFO - mozleak == 0.1 15:34:36 INFO - mozlog == 3.2 15:34:36 INFO - moznetwork == 0.27 15:34:36 INFO - mozprocess == 0.23 15:34:36 INFO - mozprofile == 0.28 15:34:36 INFO - mozrunner == 6.12 15:34:36 INFO - mozscreenshot == 0.1 15:34:36 INFO - mozsystemmonitor == 0.3 15:34:36 INFO - moztest == 0.7 15:34:36 INFO - mozversion == 1.4 15:34:36 INFO - psutil == 3.1.1 15:34:36 INFO - requests == 1.2.3 15:34:36 INFO - wsgiref == 0.1.2 15:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:36 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')]} 15:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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')]} 15:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:36 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 15:34:36 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 15:34:36 INFO - Using env: {'DISPLAY': ':0', 15:34:36 INFO - 'HOME': '/home/cltbld', 15:34:36 INFO - 'LANG': 'en_US.UTF-8', 15:34:36 INFO - 'LANGUAGE': 'en_US:en', 15:34:36 INFO - 'LOGNAME': 'cltbld', 15:34:36 INFO - 'MAIL': '/var/mail/cltbld', 15:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:36 INFO - 'MOZ_NO_REMOTE': '1', 15:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:36 INFO - 'NO_EM_RESTART': '1', 15:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:36 INFO - 'PWD': '/builds/slave/test', 15:34:36 INFO - 'SHELL': '/bin/bash', 15:34:36 INFO - 'SHLVL': '1', 15:34:36 INFO - 'TERM': 'linux', 15:34:36 INFO - 'TMOUT': '86400', 15:34:36 INFO - 'USER': 'cltbld', 15:34:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:36 INFO - '_': '/tools/buildbot/bin/python'} 15:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 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)) 15:34:36 INFO - Cleaning up... 15:34:36 INFO - Return code: 0 15:34:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34:36 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')]} 15:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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')]} 15:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:36 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 15:34:36 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 15:34:36 INFO - Using env: {'DISPLAY': ':0', 15:34:36 INFO - 'HOME': '/home/cltbld', 15:34:36 INFO - 'LANG': 'en_US.UTF-8', 15:34:36 INFO - 'LANGUAGE': 'en_US:en', 15:34:36 INFO - 'LOGNAME': 'cltbld', 15:34:36 INFO - 'MAIL': '/var/mail/cltbld', 15:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:36 INFO - 'MOZ_NO_REMOTE': '1', 15:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:36 INFO - 'NO_EM_RESTART': '1', 15:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:36 INFO - 'PWD': '/builds/slave/test', 15:34:36 INFO - 'SHELL': '/bin/bash', 15:34:36 INFO - 'SHLVL': '1', 15:34:36 INFO - 'TERM': 'linux', 15:34:36 INFO - 'TMOUT': '86400', 15:34:36 INFO - 'USER': 'cltbld', 15:34:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:36 INFO - '_': '/tools/buildbot/bin/python'} 15:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:36 INFO - Cleaning up... 15:34:36 INFO - Return code: 0 15:34:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:34:36 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')]} 15:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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')]} 15:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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 0x7ff2d942af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2769350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, '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': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', '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 15:34:36 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 15:34:36 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 15:34:36 INFO - Using env: {'DISPLAY': ':0', 15:34:36 INFO - 'HOME': '/home/cltbld', 15:34:36 INFO - 'LANG': 'en_US.UTF-8', 15:34:36 INFO - 'LANGUAGE': 'en_US:en', 15:34:36 INFO - 'LOGNAME': 'cltbld', 15:34:36 INFO - 'MAIL': '/var/mail/cltbld', 15:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:36 INFO - 'MOZ_NO_REMOTE': '1', 15:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:36 INFO - 'NO_EM_RESTART': '1', 15:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:36 INFO - 'PWD': '/builds/slave/test', 15:34:36 INFO - 'SHELL': '/bin/bash', 15:34:36 INFO - 'SHLVL': '1', 15:34:36 INFO - 'TERM': 'linux', 15:34:36 INFO - 'TMOUT': '86400', 15:34:36 INFO - 'USER': 'cltbld', 15:34:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:36 INFO - '_': '/tools/buildbot/bin/python'} 15:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:36 INFO - Downloading/unpacking flake8 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:34:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:34:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:38 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 15:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:34:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:34:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:34:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:34:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:34:39 INFO - no previously-included directories found matching 'docs/_build' 15:34:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:34:39 INFO - Running setup.py install for pep8 15:34:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:34:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:34:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:34:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:34:39 INFO - no previously-included directories found matching 'docs/_build' 15:34:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:34:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:34:39 INFO - Cleaning up... 15:34:39 INFO - Return code: 0 15:34:39 INFO - Running post-action listener: _resource_record_post_action 15:34:39 INFO - Running post-action listener: _start_resource_monitoring 15:34:39 INFO - Starting resource monitoring. 15:34:39 INFO - ##### 15:34:39 INFO - ##### Finished create-virtualenv step (success) 15:34:39 INFO - ##### 15:34:39 INFO - ##### 15:34:39 INFO - ##### Running install step. 15:34:39 INFO - ##### 15:34:39 INFO - Running pre-action listener: _resource_record_pre_action 15:34:39 INFO - Running main action method: install 15:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:39 INFO - Reading from file tmpfile_stdout 15:34:39 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:39 INFO - Reading from file tmpfile_stdout 15:34:39 INFO - Output received: 15:34:39 INFO - Usage: mozinstall [options] installer 15:34:39 INFO - Options: 15:34:39 INFO - -h, --help show this help message and exit 15:34:39 INFO - -d DEST, --destination=DEST 15:34:39 INFO - Directory to install application into. [default: 15:34:39 INFO - "/builds/slave/test"] 15:34:39 INFO - --app=APP Application being installed. [default: firefox] 15:34:39 INFO - mkdir: /builds/slave/test/build/application 15:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:34:55 INFO - Reading from file tmpfile_stdout 15:34:55 INFO - Output received: 15:34:55 INFO - /builds/slave/test/build/application/firefox/firefox 15:34:55 INFO - Running post-action listener: _resource_record_post_action 15:34:55 INFO - ##### 15:34:55 INFO - ##### Finished install step (success) 15:34:55 INFO - ##### 15:34:55 INFO - ##### 15:34:55 INFO - ##### Running run-tests step. 15:34:55 INFO - ##### 15:34:55 INFO - Running pre-action listener: _resource_record_pre_action 15:34:55 INFO - Running main action method: run_tests 15:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:34:55 INFO - Python 2.7.3 15:34:55 INFO - Return code: 0 15:34:55 INFO - grabbing minidump binary from tooltool 15:34:55 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')]} 15:34:55 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 0x27f81c0>, '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 0x27f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:34:55 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 15:34:55 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 15:34:55 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 15:34:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:34:55 INFO - Return code: 0 15:34:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:34:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:34:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:34:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:34:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:34:56 INFO - Return code: 0 15:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:34:56 INFO - Using env: {'DISPLAY': ':0', 15:34:56 INFO - 'HOME': '/home/cltbld', 15:34:56 INFO - 'LANG': 'en_US.UTF-8', 15:34:56 INFO - 'LANGUAGE': 'en_US:en', 15:34:56 INFO - 'LOGNAME': 'cltbld', 15:34:56 INFO - 'MAIL': '/var/mail/cltbld', 15:34:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:34:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:56 INFO - 'MOZ_NO_REMOTE': '1', 15:34:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:56 INFO - 'NO_EM_RESTART': '1', 15:34:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:56 INFO - 'PWD': '/builds/slave/test', 15:34:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:34:56 INFO - 'SHELL': '/bin/bash', 15:34:56 INFO - 'SHLVL': '1', 15:34:56 INFO - 'TERM': 'linux', 15:34:56 INFO - 'TMOUT': '86400', 15:34:56 INFO - 'USER': 'cltbld', 15:34:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513', 15:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:56 INFO - '_': '/tools/buildbot/bin/python'} 15:34:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:34:56 INFO - mozversion application_buildid: 20160731124125 15:34:56 INFO - mozversion application_changeset: 1a408f5eb42e99435820445547affab4e21df92e 15:34:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:34:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:34:56 INFO - mozversion application_name: Firefox 15:34:56 INFO - mozversion application_remotingname: firefox-dev 15:34:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:34:56 INFO - mozversion application_vendor: Mozilla 15:34:56 INFO - mozversion application_version: 49.0a2 15:34:56 INFO - mozversion platform_buildid: 20160731124125 15:34:56 INFO - mozversion platform_changeset: 1a408f5eb42e99435820445547affab4e21df92e 15:34:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:34:56 INFO - mozversion platform_version: 49.0a2 15:34:56 INFO - using testdate: 1470004496 15:34:56 INFO - actual date: 1470004496 15:34:56 INFO - starting webserver on 'localhost:55034' 15:34:56 INFO - SUITE-START | Running 2 tests 15:34:56 INFO - TEST-START | dromaeo_css 15:34:56 INFO - operating with platform_type : linux_ 15:34:56 INFO - Initialising browser for dromaeo_css test... 15:34:56 INFO - TEST-INFO | started process 2823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3apa9/profile http://localhost:55034/getInfo.html) 15:35:01 INFO - PROCESS | 2823 | __metrics Screen width/height:1600/1200 15:35:01 INFO - PROCESS | 2823 | colorDepth:24 15:35:01 INFO - PROCESS | 2823 | Browser inner width/height: 1024/697 15:35:01 INFO - PROCESS | 2823 | __metrics 15:35:01 ERROR - PROCESS | 2823 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 15:35:02 INFO - TEST-INFO | 2823: exit 0 15:35:02 INFO - Browser initialized. 15:35:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:35:02 INFO - TEST-INFO | started process 2987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn3apa9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:14 INFO - PROCESS | 2987 | RSS: Main: 154103808 15:35:14 INFO - PROCESS | 2987 | 15:36:03 INFO - PROCESS | 2987 | 1470004563936 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] 15:38:11 INFO - PROCESS | 2987 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55034/tests/dromaeo/cssquery-ext.html) 15:38:12 INFO - PROCESS | 2987 | RSS: Main: 158781440 15:38:12 INFO - PROCESS | 2987 | 15:41:14 INFO - PROCESS | 2987 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-ext.html (next: http://localhost:55034/tests/dromaeo/cssquery-jquery.html) 15:41:15 INFO - PROCESS | 2987 | RSS: Main: 156139520 15:41:15 INFO - PROCESS | 2987 | 15:44:17 INFO - PROCESS | 2987 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55034/tests/dromaeo/cssquery-mootools.html) 15:44:17 INFO - PROCESS | 2987 | RSS: Main: 156364800 15:44:17 INFO - PROCESS | 2987 | 15:47:19 INFO - PROCESS | 2987 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55034/tests/dromaeo/cssquery-prototype.html) 15:47:20 INFO - PROCESS | 2987 | RSS: Main: 155549696 15:47:20 INFO - PROCESS | 2987 | 15:50:22 INFO - PROCESS | 2987 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55034/tests/dromaeo/cssquery-yui.html) 15:50:23 INFO - PROCESS | 2987 | RSS: Main: 157712384 15:50:23 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | Cycle 1(1): loaded http://localhost:55034/tests/dromaeo/cssquery-yui.html (next: http://localhost:55034/tests/dromaeo/cssquery-dojo.html) 15:53:25 INFO - PROCESS | 2987 | RSS: Main: 157765632 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | __start_tp_report 15:53:25 INFO - PROCESS | 2987 | _x_x_mozilla_page_load 15:53:25 INFO - PROCESS | 2987 | _x_x_mozilla_page_load_details 15:53:25 INFO - PROCESS | 2987 | |i|pagename|runs| 15:53:25 INFO - PROCESS | 2987 | |0;dojo.html;3337.098983274516;3359.9496007559883;3366.966330336696;3384.8984530464095;3387.508811222371;5516.7517461714215;5563.248961390211;5584.441555844413;5604.1593760935775;5634.802781902634;5636.18275350074;5665.263515742958;5667.376588575254;5668.603197776158;5687.203791469197;5043.697378157322;5124.795008199686;5167.741612919339;5195.168772996321;5199.818006369778;5051.9494805051845;5054.444011158769;5099.031184075033;5199.948000519984;5208.635395522315;5113.744312784346;5117.641765076446;5123.2315152727015;5127.717975511346;5134.563562097226;5105.84682459525;5195.922061169085;5198.142306519419;5205.661631993946;5241.9213711794355;4927.876803079916;5018.247262910592;5085.644004919657;5153.458886816868;5163.1480805667015;5378.300820893298;5432.022235997519;5443.42844001382;5471.343438787331;5496.285482887239;5938.257717785277;5980.192673989043;5980.790672326491;5989.071693887455;5990.251218597676;5868.735906884201;5951.791687290924;6055.303640081403;6057.151998720183;6071.787487437919;5562.805301814417;5672.5178359839465;5682.318121825366;5683.090705487143;5716.857078573027;6159.353267906805;6159.784407545714;6164.137020817089;6164.845878853064;6180.072989051679;5704.401037890962;5759.136129580513;5812.186293918855;5929.258842644669;5949.970250148808;5958.404159584094;5964.373740757244;5975.790847320323;5977.910331345033;5999.310079340845;5855.765769369177;5916.792912248136;5929.9110513341475;5976.372480889531;5980.521558275327;5827.271591051119;5866.941330586725;5868.061110222344;5920.585559010828;5992.520598352121;4584.33527138563;4594.540545945379;4598.471175814824;4599.9080018399445;4614.815407383667;4125.752454852718;4143.129942712064;4150.315197992298;4157.210130075276;4167.791610419527;5635.070213414822;5752.3097228332035;5753.05074662676;5766.711664416763;5807.970960145257;5865.67738774363;5917.349091599921;5929.792457263975;6009.609375390585;6039.456448919531;5641.182028605829;5742.109972954198;5763.538916886639;5777.913331300034;5778.855528611734;5165.612579056586;5177.249298851645;5186.170212765939;5211.140161873324;5219.243209734567;6245.500359971192;6246.312905580383;6270.561060725797;6300.527460440394;6332.905006424908;5889.52883769306;5969.641821490724;6012.338642749294;6030.185924900258;6037.849053773691;6167.290761562478;6296.496280297473;6296.653684047421;6302.338254483213;6318.462930650946;5951.285845698544;5960.105984102246;5963.165156878127;5964.701764911824;5998.580099393001;5899.439553242435;5920.79277225295;5997.100434934795;6037.305709843248;6060.060690592965;5939.970300148471;5946.494547963472;5957.255343082114;5961.821145365646;5970.910436343372;5879.823605291848;5913.58604897653;5916.73374698131;5928.49607783326;5944.3164036136395;5669.6314739541795;5694.686792226467;5697.003024470619;5763.164341170591;5764.827055188351;5808.5062769665055;5858.2677165354335;5888.057910734262;5904.3210030847;5905.084711869667;5755.769769209185;5760.423957604374;5776.768929242783;5778.248827652378;5787.131930210502 15:53:25 INFO - PROCESS | 2987 | |1;ext.html;589.9085641725534;644.8001119652907;650.7039297119811;651.1372431528226;662.0929326822254;44880.32679509806;46124.308135377956;46340.768296158516;46596;50111.24833127497;46898.53101468984;46971;47049.529504704944;47501.52498475014;47626.285605715944;8974.820503589941;9111.68109116181;9133.36066475347;9138.99471058183;9142.588583513758;8954.86567701485;9005.054469280729;9028.32287578431;9051.818963620724;9071.41035832672;9028.68399606014;9056.909430905673;9096.681616143436;9113.908860911371;9114.225290850252;9016.188543031127;9062.410943288698;9076.546172691338;9094.136057074567;9112.772180695469;8914.86627700585;8952.283817294601;8968.103189681045;8972.371933964625;8998.370114092017;44958.32562511565;45575.54424455746;45595.77202113968;45599;45827.31259031117;3700.389435743099;3868.7485313454536;3927.136030073379;4083.591640835922;4126.938095928564;34581.481277780855;34648.65351346479;34861.651383486096;34991.475127873106;35215.647843521496;4705.294205869112;4763.3807605011125;4785.712857228577;4808.975955120237;4828.37231159947;365691;366683;366847.9999999973;370529;370567;56655.43344566584;61911.380886191466;61998.38001619926;62189;62431.6878415605;38545.61454385476;39676.20647587032;39900.40149397762;65326.673366632866;65433;19475.707864382046;19530.70703939442;19557.804421955883;19653.901730491543;19743.703844442345;14847;14941.551753447415;14993.850061499244;15028.17345046033;15052;20864.47838804042;20909.895450522956;20971.8951405242;21058.578828423346;21120.366389008355;7342.192358840523;7597.392208623297;7637.198094200029;7696.345810606162;7887.921120788834;965.7199412170532;1072.7961687279549;1094.6715985204567;1175.2360965372577;1183.7632473505162;32892.50661240083;33182.170445738564;33198.66801332004;33539;33554.83222583871;1140.0822338017974;1156.1444531047132;1157.484919210943;1171.9062475001979;1192.8389667394965;17246.65506689859;17604.735928961076;17709.29162833498;17743.467695969142;17764.289428422977;590471;616923;622931;626396;858066;63292.68353658202;63782;63886;63948.36051639517;64203.35796642067;1477.416420513891;1507.4723846653803;1511.8185817701726;1523.8875620797103;1528.2893454543691;32567.511487328182;32791.18022049468;33139.50290745593;33227;33942;54748;60637.69681151566;60825.69587152036;60846.391536085845;60923;533105;535070;538109;538378;538600;30079.548806768355;31224.375512490078;31270.53094203634;32110.67889321077;45422.77288613536;50867.491325086274;51430.22854657108;51628.483715162365;51740.74129629328;52799.47200527946;42899.57100428956;43308.566914330455;43310.56689433065;43793.562064380225;43833.78083109564;41311.173776524905;44373;45278;45316.32025519554;46292.30561541512;42318.36522452227;43922.78038609914;44705.776471118734;44836.77581612071;44863.55136448724;37095.25809483849;38251.23497529978;38678.41982370323;39343.80328098341;39555.40666889941;29434.705652944052;29771.55342669905;29789.702102978692;30102.24744381408;30273.848630756704 15:53:25 INFO - PROCESS | 2987 | |2;jquery.html;419.3374468340023;425.44904348868215;426.07329059296035;434.25091716788523;444.81540160833254;18297.17662705178;19133.139008744623;19951;20796.272130475438;20813.16747330105;19440.61118777627;19521.902390488063;19849.603007939833;20178;20225.898870505665;5639.295088113976;5757.050086735683;5836.241288632493;5842.970785146068;5845.09401042839;5612.607117501777;5738.454846789548;5780.884382312352;5783.248177736909;5862.736176872029;5790.913136302959;5795.507381872546;5805.883882322351;5806.071028635419;5808.709564521778;5627.296587926509;5777.451142141511;5797.507211886995;5832;5843.970780146094;5199.584033277329;5211.1922651989;5215.452377500345;5240.554552863011;5253.553447956928;22344.664830027563;23086.53826923469;23356.53286934269;23368.53262934732;23587.764122358727;2497.4505608766044;2612.4644447888327;2628.566286562715;2649.112547296658;2864.7851411144247;10004.54979525923;10248.23138264633;10547.208959328082;10712.571497140105;10816.945915270373;2053.16846677096;2132.243053715924;2136.7115439415634;2160.837937154704;2211.1487077475126;66791;76843.61578192073;88554.55722721345;89732.17173249967;91897.54051229768;11189;11473.598424055119;11513.769724605461;11519.769604607862;11668.88331116695;16392.508224753277;16400.75398869018;16423.260953257133;16537.586560335847;16545.66908661844;8928.10718928102;8933.374663773473;9010.234130099016;9047.592858321392;9114.316426268057;8937.776555586162;8971.282297416321;8976.147266009719;9017.368784185044;9093.727188184364;4644.698094623838;4832.395950506187;4951.405831300267;4972.7513624318635;4985.725785081855;1941.213808407597;2001.7998200180157;2024.9898750506154;2067.700183473388;2144.3995681209285;962.1917589225085;1009.1069403577886;1024.4109636958779;1098.9230753847314;1110.74452875839;17250.913745431444;17885.105744712713;18452.90773546124;19170.71243931342;19272.710909336372;1039.7608550033535;1051.8422236664562;1056.2447849787438;1081.324172392255;1083.2200815412891;10297.742556436;10676.359418434919;10732.570697172181;10757.784844303227;10855;506701;513234;513932;518955;525624;70546.294537055;94541.5272923631;96360;97045.51477242568;98142;978.3396207559869;1083.2146693647044;1084.1706094837455;1084.7125511739396;1085.4193006741355;17291.740623890902;17457;17476.388326408516;17525.47423577295;17739.73390399171;37937.24125517529;39229.215415692095;40215.597844022355;40289.79855100706;42652;53257.46742532525;54776.452235478726;60691.39308607034;63120.68439657772;63782.3621763795;8046.557439340892;8152.9184708154535;8260.752177434686;8289.626966786629;8613.612387442705;11921.642350729491;13006.739865202831;13073.542426015043;13387.196768193939;13688.31558422055;5697.715114244188;9043.728688139367;10251.333663311862;10669.35983840972;10783.6225732099;11451.59919402817;11507.884921150682;11638.6508404748;11836.289822610672;11940.164188506722;8309.335253179852;10827;10998.230123891251;11134.777304454028;11185.384803835866;7527.059117610299;7704.961475192588;7897.328727058264;8107.432479726598;8830.514321712368;10509.842352364874;10874.782504350027;10962.725931851768;10964.725881853017;11034.779304414027 15:53:25 INFO - PROCESS | 2987 | |3;mootools.html;1548.9922550387246;1566.7336552786026;1786.428342930263;1871.9532011699714;1913.502489352768;8059.91940080599;8642;8651;9214.723558293244;9226;8721.781955451117;8964.148405901446;9009.639614415415;9017.368784185093;9062.184403403693;2420.3465064432594;2428.76926691964;2444.706635203778;2454.5949918263464;2465.950680986379;2398.352444839892;2416.5650182967147;2445.9021639134503;2448.424620214248;2455.0179928028842;2392.35406440261;2397.808175345977;2405.6632071510003;2411.3248290478696;2413.987930060347;2328.604137296664;2342.8828558572172;2347.80043696286;2351.823613229015;2366.1718398560365;2314.664373665809;2364.219807463533;2395.6646069550275;2403.086827005744;2405.302462285935;9063.274938004944;9097.909020909772;9158.17576418119;9164.037776033554;9181.449113053171;5397.190421436777;5434.239206511092;5470.6444081135;5505.146702261156;5516.200150978086;3542.3800834854055;3571.4642803579673;3588.4617307403837;3633.3278343506536;3678.926421471582;1242.4781591731494;1253.3419954523856;1267.1256832785348;1268.391172237322;1285.3637449462576;12365.38173091342;12497.812532812015;12519.874801251963;12539.749205015849;12558.74882502354;4697.084068606658;4697.224957881979;4806.086843499724;4812.5668689818085;4843.491433399513;10672.30630009047;10711.143108551298;10729.088027517591;10734.033936945712;10743.946280268548;5462.863428414242;5463.672179669233;5501.697406642593;5506.394296627368;5529.087700529368;4457.68796184264;4861.951380486221;5022.59819214462;5026.924596131061;5082.949170508322;4146.91706165881;4200.3699445082875;4203.873883783492;4276.764777937244;4425.513193548707;1277.495389321213;1290.2967882504058;1306.324680880699;1313.1398933698442;1318.2090745552591;862.8188080503039;879.160401816264;958.1711819276276;989.7970915962211;1030.0883717909553;6252.468540174136;6262.499000079983;6282.717277722513;6287.748490060347;6293.056041593798;474.2625217786375;478.7103802199689;480.1117931826094;488.57738056581513;489.080528606218;4299.849505267301;4422.226110430726;4519.751413672214;4537.75042372666;4557.065801510682;10559.524821383056;10811.35131892089;10830.945845270724;10890.564377424973;10891.509882055168;10386.584536618602;10673.199510036779;10729.302595331279;10738.087262582612;10754.516046777913;8363;8502.234798868132;8508.659653613786;8516.914830851612;8568.314534837198;5933.881322373615;5934.732937017931;6089.969550152221;6147.66187859672;6206.813795585959;9931.851022234529;10024.749381265236;10050.09549140581;10092.091711745978;10170.898291016994;10334.224933129895;10592;10609;10631.574737010433;10728.51721672511;6847.486438517031;7959.761207163794;7993.520388776692;8086.272235498834;8127.146649601943;8824.11758824138;8861.379703420698;8889.333300002654;8910.108989101038;8912.86630700553;7982.201779821971;8137.064237612751;8169.5506747129475;8240.62917168717;8302.252797248277;7719.266669666373;7838.098618658927;7843.450958432855;7850.842983140419;7957.482763620346;7193.964030179815;7215.891761623475;7229.855402892018;7292.744753933587;7299.124105107421;5471.343438787371;5475.123980163155;5502.422245664147;5518.392976772471;5544.7782088716;5319.840404787863;5357.70532620694;5394.9460505394445;5435.429279925551;5579.553635709215 15:53:25 INFO - PROCESS | 2987 | |4;prototype.html;345.3007659489535;348.445970906259;349.6189153822333;350.479537886239;352.7283991326678;5756.618411581222;5791.594588378815;5797.333306669734;5820.53435725142;5829.213056237407;5740.655560666352;5751.396103409144;5773.076307790754;5786.68173250471;5789.652620842752;4102.282100632392;4402.779861006953;4407.559244075599;4431.88920276994;4453.28747400416;4402.339649052652;4421.867343979686;4446.177457170417;4451.866444006685;4466.173757854791;4426.44669416323;4428;4435.090806384699;4464.531224221459;4467.910641787163;4280.74315541067;4398.868033958986;4403.075354175627;4405.251107311765;4424.690271680984;3927.705422093326;3952.505936757905;3955.564887862333;3965.4250133730734;3969.6824254059607;5445.700486473243;5470.617056806025;5478.58910581704;5495.148252020943;5508.127236739528;4859.659823812334;4995.550400463976;5063.670861393997;5089.592832573385;5090.898182036375;5942.197803296586;5943.762249510014;5955.702214889238;5967.970160149215;5972.223610930595;4185.727927684691;4229.154169166179;4230.344296634026;4249.4475718156755;4263.616274535307;6002.669853158074;6148.84627884302;6180.845478863064;6208.348123447018;6212.378762123797;4222.345536441856;4230.450041494648;4231.217224813419;4236.639885609696;4271.508776490681;4315.8489452869;4328.956710432918;4336.674749393808;4344.45694288214;4360.084382279757;4911.877203069952;5005.822467226768;5009.749512524432;5011.57401620859;5017.397912250553;5996.4603185713495;6018.15745795589;6034.172661870486;6036.3058248302;6041.365656606081;1481.3111902965172;1510.9800884402985;1512.8714059304862;1534.907905525672;1541.2370876416246;944.3059351376733;1023.0459821740588;1041.6874937518864;1043.5564884924029;1050.9159267258601;5847.181394604759;5885.61743486672;5945.7621695132575;5947.256592925884;5960.254968128984;6161.106639537332;6189.659568723763;6195.256569211723;6195.907061394083;6232.750689972441;5595.692236927008;5824.893270278633;5900.527957763368;5924.31870334917;5928.318243401977;3254.5280934264397;3299.884504042347;3301.1747063234193;3307.5534802801794;3319.7344212462945;6260.116038745949;6461.644609546426;6465.903011454832;6507.8698426031215;6509.446697030806;6333.050042493663;6354.205724284465;6364.6316042051185;6387.201599800025;6391.872162556816;6136.8772624547255;6488.545801793829;6504.219493660886;6521.510886683518;6528.869422611616;6197.411245931629;6222.191115155001;6238.968805155945;6243.937560624336;6282.277538082996;6042.093685947143;6120.265568131853;6126.417990290915;6167.660778657217;6168.753249869955;6418.326075761977;6475.740970361133;6488.2538508072175;6504.38208370204;6504.739810407531;4220.66234701217;4271.060366719316;4288.742675439484;4292.849750258851;4303.634191093792;6044.848878778066;6145;6229.4393504584805;6238.313785483684;6298.1812364392335;6041.78853740117;6047.667378294236;6068.4841788448475;6108.938910610837;6127.601705889103;5881.38245484218;6009.158717779427;6010.459058684739;6013.368596297326;6049.7011135768125;5808.970955145197;5927.288725352985;5946.226990491208;5960.374160713062;5970.223870896755;6123.418275263843;6131.872744900223;6133.478654314434;6134.466383404149;6204.224471941007;5846.619969701956;5953.791617293374;5974.1636170935235;5976.462118409364;6011.849703757441 15:53:25 INFO - PROCESS | 2987 | |5;yui.html;792.19196419652;801.2548330053052;804.4610111225478;871.7689812199767;892.081156408899;16574.502764917055;17458.738118928228;17480.125993700294;17504.91247543762;17601.295948162075;16132.112733799666;16192;16271.186440677979;16281.83718162818;16321.918390408062;706.7985624097107;846.4836449765638;847.745676297113;875.7504111328273;877.9912200878006;864.654138344664;866.0084203586889;867.2584939876378;867.8524650809346;873.1181506678269;925.4771054354302;926.036921601537;926.1340646495514;926.5598840550751;927.8747369105185;919.0992827029515;922.1424075609681;925.4586067150691;925.5788616179622;926.7775733823901;669.7354544954716;671.0906721392491;671.67088126818;673.4309508465338;675.0178490296655;15090.39638414462;15104.848951510454;15140.091594504365;15157.014794038352;15208.619784505365;15237.847621523753;16187.19064046793;16636.08501532415;16636.916815415967;16648;12368.628941131781;12372.257664540157;13584.932075339659;13718.314084295846;13921.721565568632;4734.763261836894;4789.090072886141;4863.513648635144;4892.168331383637;4898.24077268024;78044.60977695131;78293.60853195812;79111.604441978;79370;79926;12234.449449774782;12298.815517767242;12301.507939682313;12336;12460.75078498425;21429.67855482169;21595.460113497287;21637;21719.457013574785;21736.456588585414;8897.955510222408;8961.596728147118;9011.63953441855;9147.817043659223;9156.496392698466;5112.079825631347;5216.504432078947;5260.210968354778;5302.602304827076;5351.705656188947;3557.7331700122595;3671.706263498967;3672.5225720656144;3674.228412033503;3678.0620941659704;642.6465444005871;643.9388258115472;644.1239913717341;650.2944305428568;661.4609093588709;685.3283781893672;719.3022767915114;722.360710770961;734.0494060192065;735.7902997645646;9755.512224388753;10035.598576056876;10062.597496100074;10090.848637270446;10111.241656875764;757.4394947738633;774.2180397798264;775.6276987046136;779.8518281526492;781.121403025724;4684.789184486706;4744.739039352799;4822.7829747661435;4864.586510146606;4866.683665561727;91526.54236728908;114704;114963;119399;119484;92511.07488925025;103112.48443757734;104760;104838.47580762047;106613;62364;90180;90386.09613903909;90969;91543.54228228817;9397.637342585424;9468.573914173741;9493.145616894513;9535.713928582154;9545.570449329658;36731.81634091919;37243.62756372402;50548.74725626349;53747;54901.725491372286;67613.32386676071;68132;68356.65821671058;68857.3114268871;75739.24260757542;13398.732025359242;14130.364133613806;14362.281885905453;14571.198584077554;14776.63058423505;15217.239138043275;15223.695526089195;15317.157556334509;16321.918390407973;16503.422380216634;14685.48600798967;15046.32291546861;15248.31382587764;15456.92271538635;15668.529944101696;13799.172049677052;14106.2946852659;14310.212938288494;14356.856431435552;14858;13265.933670331586;13267.33663316811;13692.794608080687;13721.108127971649;13754.587362379145;11921.957422290161;12032.578859739868;12269.509219631114;12365.443555040225;12379.257244565355;11545.595904143314;12399.194052386567;12591.181573197713;12622;12683.619491415273 15:53:25 INFO - PROCESS | 2987 | __end_tp_report 15:53:25 INFO - PROCESS | 2987 | __start_cc_report 15:53:25 INFO - PROCESS | 2987 | _x_x_mozilla_cycle_collect,330 15:53:25 INFO - PROCESS | 2987 | __end_cc_report 15:53:25 INFO - PROCESS | 2987 | __startTimestamp1470005605819__endTimestamp 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | ------- Summary: start ------- 15:53:25 INFO - PROCESS | 2987 | Number of tests: 6 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | [#0] dojo.html Cycles:165 Average:5583.36 Median:5777.91 stddev:613.34 (10.6%) stddev-sans-first:589.36 15:53:25 INFO - PROCESS | 2987 | Values: 3337.1 3359.9 3367.0 3384.9 3387.5 5516.8 5563.2 5584.4 5604.2 5634.8 5636.2 5665.3 5667.4 5668.6 5687.2 5043.7 5124.8 5167.7 5195.2 5199.8 5051.9 5054.4 5099.0 5199.9 5208.6 5113.7 5117.6 5123.2 5127.7 5134.6 5105.8 5195.9 5198.1 5205.7 5241.9 4927.9 5018.2 5085.6 5153.5 5163.1 5378.3 5432.0 5443.4 5471.3 5496.3 5938.3 5980.2 5980.8 5989.1 5990.3 5868.7 5951.8 6055.3 6057.2 6071.8 5562.8 5672.5 5682.3 5683.1 5716.9 6159.4 6159.8 6164.1 6164.8 6180.1 5704.4 5759.1 5812.2 5929.3 5950.0 5958.4 5964.4 5975.8 5977.9 5999.3 5855.8 5916.8 5929.9 5976.4 5980.5 5827.3 5866.9 5868.1 5920.6 5992.5 4584.3 4594.5 4598.5 4599.9 4614.8 4125.8 4143.1 4150.3 4157.2 4167.8 5635.1 5752.3 5753.1 5766.7 5808.0 5865.7 5917.3 5929.8 6009.6 6039.5 5641.2 5742.1 5763.5 5777.9 5778.9 5165.6 5177.2 5186.2 5211.1 5219.2 6245.5 6246.3 6270.6 6300.5 6332.9 5889.5 5969.6 6012.3 6030.2 6037.8 6167.3 6296.5 6296.7 6302.3 6318.5 5951.3 5960.1 5963.2 5964.7 5998.6 5899.4 5920.8 5997.1 6037.3 6060.1 5940.0 5946.5 5957.3 5961.8 5970.9 5879.8 5913.6 5916.7 5928.5 5944.3 5669.6 5694.7 5697.0 5763.2 5764.8 5808.5 5858.3 5888.1 5904.3 5905.1 5755.8 5760.4 5776.8 5778.2 5787.1 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | [#1] ext.html Cycles:180 Average:68558.77 Median:45297.16 stddev:143898.60 (317.7%) stddev-sans-first:144211.79 15:53:25 INFO - PROCESS | 2987 | Values: 589.9 644.8 650.7 651.1 662.1 44880.3 46124.3 46340.8 46596.0 50111.2 46898.5 46971.0 47049.5 47501.5 47626.3 8974.8 9111.7 9133.4 9139.0 9142.6 8954.9 9005.1 9028.3 9051.8 9071.4 9028.7 9056.9 9096.7 9113.9 9114.2 9016.2 9062.4 9076.5 9094.1 9112.8 8914.9 8952.3 8968.1 8972.4 8998.4 44958.3 45575.5 45595.8 45599.0 45827.3 3700.4 3868.7 3927.1 4083.6 4126.9 34581.5 34648.7 34861.7 34991.5 35215.6 4705.3 4763.4 4785.7 4809.0 4828.4 365691.0 366683.0 366848.0 370529.0 370567.0 56655.4 61911.4 61998.4 62189.0 62431.7 38545.6 39676.2 39900.4 65326.7 65433.0 19475.7 19530.7 19557.8 19653.9 19743.7 14847.0 14941.6 14993.9 15028.2 15052.0 20864.5 20909.9 20971.9 21058.6 21120.4 7342.2 7597.4 7637.2 7696.3 7887.9 965.7 1072.8 1094.7 1175.2 1183.8 32892.5 33182.2 33198.7 33539.0 33554.8 1140.1 1156.1 1157.5 1171.9 1192.8 17246.7 17604.7 17709.3 17743.5 17764.3 590471.0 616923.0 622931.0 626396.0 858066.0 63292.7 63782.0 63886.0 63948.4 64203.4 1477.4 1507.5 1511.8 1523.9 1528.3 32567.5 32791.2 33139.5 33227.0 33942.0 54748.0 60637.7 60825.7 60846.4 60923.0 533105.0 535070.0 538109.0 538378.0 538600.0 30079.5 31224.4 31270.5 32110.7 45422.8 50867.5 51430.2 51628.5 51740.7 52799.5 42899.6 43308.6 43310.6 43793.6 43833.8 41311.2 44373.0 45278.0 45316.3 46292.3 42318.4 43922.8 44705.8 44836.8 44863.6 37095.3 38251.2 38678.4 39343.8 39555.4 29434.7 29771.6 29789.7 30102.2 30273.8 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | [#2] jquery.html Cycles:180 Average:29722.23 Median:2554.96 stddev:84958.80 (3325.3%) stddev-sans-first:85168.64 15:53:25 INFO - PROCESS | 2987 | Values: 419.3 425.4 426.1 434.3 444.8 18297.2 19133.1 19951.0 20796.3 20813.2 19440.6 19521.9 19849.6 20178.0 20225.9 5639.3 5757.1 5836.2 5843.0 5845.1 5612.6 5738.5 5780.9 5783.2 5862.7 5790.9 5795.5 5805.9 5806.1 5808.7 5627.3 5777.5 5797.5 5832.0 5844.0 5199.6 5211.2 5215.5 5240.6 5253.6 22344.7 23086.5 23356.5 23368.5 23587.8 2497.5 2612.5 2628.6 2649.1 2864.8 10004.5 10248.2 10547.2 10712.6 10816.9 2053.2 2132.2 2136.7 2160.8 2211.1 66791.0 76843.6 88554.6 89732.2 91897.5 11189.0 11473.6 11513.8 11519.8 11668.9 16392.5 16400.8 16423.3 16537.6 16545.7 8928.1 8933.4 9010.2 9047.6 9114.3 8937.8 8971.3 8976.1 9017.4 9093.7 4644.7 4832.4 4951.4 4972.8 4985.7 1941.2 2001.8 2025.0 2067.7 2144.4 962.2 1009.1 1024.4 1098.9 1110.7 17250.9 17885.1 18452.9 19170.7 19272.7 1039.8 1051.8 1056.2 1081.3 1083.2 10297.7 10676.4 10732.6 10757.8 10855.0 506701.0 513234.0 513932.0 518955.0 525624.0 70546.3 94541.5 96360.0 97045.5 98142.0 978.3 1083.2 1084.2 1084.7 1085.4 17291.7 17457.0 17476.4 17525.5 17739.7 37937.2 39229.2 40215.6 40289.8 42652.0 53257.5 54776.5 60691.4 63120.7 63782.4 8046.6 8152.9 8260.8 8289.6 8613.6 11921.6 13006.7 13073.5 13387.2 13688.3 5697.7 9043.7 10251.3 10669.4 10783.6 11451.6 11507.9 11638.7 11836.3 11940.2 8309.3 10827.0 10998.2 11134.8 11185.4 7527.1 7705.0 7897.3 8107.4 8830.5 10509.8 10874.8 10962.7 10964.7 11034.8 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | [#3] mootools.html Cycles:180 Average:5958.51 Median:2643.10 stddev:3339.60 (126.4%) stddev-sans-first:3332.53 15:53:25 INFO - PROCESS | 2987 | Values: 1549.0 1566.7 1786.4 1872.0 1913.5 8059.9 8642.0 8651.0 9214.7 9226.0 8721.8 8964.1 9009.6 9017.4 9062.2 2420.3 2428.8 2444.7 2454.6 2466.0 2398.4 2416.6 2445.9 2448.4 2455.0 2392.4 2397.8 2405.7 2411.3 2414.0 2328.6 2342.9 2347.8 2351.8 2366.2 2314.7 2364.2 2395.7 2403.1 2405.3 9063.3 9097.9 9158.2 9164.0 9181.4 5397.2 5434.2 5470.6 5505.1 5516.2 3542.4 3571.5 3588.5 3633.3 3678.9 1242.5 1253.3 1267.1 1268.4 1285.4 12365.4 12497.8 12519.9 12539.7 12558.7 4697.1 4697.2 4806.1 4812.6 4843.5 10672.3 10711.1 10729.1 10734.0 10743.9 5462.9 5463.7 5501.7 5506.4 5529.1 4457.7 4862.0 5022.6 5026.9 5082.9 4146.9 4200.4 4203.9 4276.8 4425.5 1277.5 1290.3 1306.3 1313.1 1318.2 862.8 879.2 958.2 989.8 1030.1 6252.5 6262.5 6282.7 6287.7 6293.1 474.3 478.7 480.1 488.6 489.1 4299.8 4422.2 4519.8 4537.8 4557.1 10559.5 10811.4 10830.9 10890.6 10891.5 10386.6 10673.2 10729.3 10738.1 10754.5 8363.0 8502.2 8508.7 8516.9 8568.3 5933.9 5934.7 6090.0 6147.7 6206.8 9931.9 10024.7 10050.1 10092.1 10170.9 10334.2 10592.0 10609.0 10631.6 10728.5 6847.5 7959.8 7993.5 8086.3 8127.1 8824.1 8861.4 8889.3 8910.1 8912.9 7982.2 8137.1 8169.6 8240.6 8302.3 7719.3 7838.1 7843.5 7850.8 7957.5 7194.0 7215.9 7229.9 7292.7 7299.1 5471.3 5475.1 5502.4 5518.4 5544.8 5319.8 5357.7 5394.9 5435.4 5579.6 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | [#4] prototype.html Cycles:180 Average:5065.23 Median:5827.05 stddev:1517.58 (26.0%) stddev-sans-first:1479.91 15:53:25 INFO - PROCESS | 2987 | Values: 345.3 348.4 349.6 350.5 352.7 5756.6 5791.6 5797.3 5820.5 5829.2 5740.7 5751.4 5773.1 5786.7 5789.7 4102.3 4402.8 4407.6 4431.9 4453.3 4402.3 4421.9 4446.2 4451.9 4466.2 4426.4 4428.0 4435.1 4464.5 4467.9 4280.7 4398.9 4403.1 4405.3 4424.7 3927.7 3952.5 3955.6 3965.4 3969.7 5445.7 5470.6 5478.6 5495.1 5508.1 4859.7 4995.6 5063.7 5089.6 5090.9 5942.2 5943.8 5955.7 5968.0 5972.2 4185.7 4229.2 4230.3 4249.4 4263.6 6002.7 6148.8 6180.8 6208.3 6212.4 4222.3 4230.5 4231.2 4236.6 4271.5 4315.8 4329.0 4336.7 4344.5 4360.1 4911.9 5005.8 5009.7 5011.6 5017.4 5996.5 6018.2 6034.2 6036.3 6041.4 1481.3 1511.0 1512.9 1534.9 1541.2 944.3 1023.0 1041.7 1043.6 1050.9 5847.2 5885.6 5945.8 5947.3 5960.3 6161.1 6189.7 6195.3 6195.9 6232.8 5595.7 5824.9 5900.5 5924.3 5928.3 3254.5 3299.9 3301.2 3307.6 3319.7 6260.1 6461.6 6465.9 6507.9 6509.4 6333.1 6354.2 6364.6 6387.2 6391.9 6136.9 6488.5 6504.2 6521.5 6528.9 6197.4 6222.2 6239.0 6243.9 6282.3 6042.1 6120.3 6126.4 6167.7 6168.8 6418.3 6475.7 6488.3 6504.4 6504.7 4220.7 4271.1 4288.7 4292.8 4303.6 6044.8 6145.0 6229.4 6238.3 6298.2 6041.8 6047.7 6068.5 6108.9 6127.6 5881.4 6009.2 6010.5 6013.4 6049.7 5809.0 5927.3 5946.2 5960.4 5970.2 6123.4 6131.9 6133.5 6134.5 6204.2 5846.6 5953.8 5974.2 5976.5 6011.8 15:53:25 INFO - PROCESS | 2987 | 15:53:25 INFO - PROCESS | 2987 | [#5] yui.html Cycles:180 Average:21076.27 Median:4739.75 stddev:29650.32 (625.6%) stddev-sans-first:29694.38 15:53:25 INFO - PROCESS | 2987 | Values: 792.2 801.3 804.5 871.8 892.1 16574.5 17458.7 17480.1 17504.9 17601.3 16132.1 16192.0 16271.2 16281.8 16321.9 706.8 846.5 847.7 875.8 878.0 864.7 866.0 867.3 867.9 873.1 925.5 926.0 926.1 926.6 927.9 919.1 922.1 925.5 925.6 926.8 669.7 671.1 671.7 673.4 675.0 15090.4 15104.8 15140.1 15157.0 15208.6 15237.8 16187.2 16636.1 16636.9 16648.0 12368.6 12372.3 13584.9 13718.3 13921.7 4734.8 4789.1 4863.5 4892.2 4898.2 78044.6 78293.6 79111.6 79370.0 79926.0 12234.4 12298.8 12301.5 12336.0 12460.8 21429.7 21595.5 21637.0 21719.5 21736.5 8898.0 8961.6 9011.6 9147.8 9156.5 5112.1 5216.5 5260.2 5302.6 5351.7 3557.7 3671.7 3672.5 3674.2 3678.1 642.6 643.9 644.1 650.3 661.5 685.3 719.3 722.4 734.0 735.8 9755.5 10035.6 10062.6 10090.8 10111.2 757.4 774.2 775.6 779.9 781.1 4684.8 4744.7 4822.8 4864.6 4866.7 91526.5 114704.0 114963.0 119399.0 119484.0 92511.1 103112.5 104760.0 104838.5 106613.0 62364.0 90180.0 90386.1 90969.0 91543.5 9397.6 9468.6 9493.1 9535.7 9545.6 36731.8 37243.6 50548.7 53747.0 54901.7 67613.3 68132.0 68356.7 68857.3 75739.2 13398.7 14130.4 14362.3 14571.2 14776.6 15217.2 15223.7 15317.2 16321.9 16503.4 14685.5 15046.3 15248.3 15456.9 15668.5 13799.2 14106.3 14310.2 14356.9 14858.0 13265.9 13267.3 13692.8 13721.1 13754.6 11922.0 12032.6 12269.5 12365.4 12379.3 11545.6 12399.2 12591.2 12622.0 12683.6 15:53:25 INFO - PROCESS | 2987 | -------- Summary: end -------- 15:53:25 INFO - PROCESS | 2987 | 15:53:26 INFO - TEST-INFO | 2987: exit 0 15:53:26 INFO - TEST-OK | dromaeo_css | took 1110037ms 15:53:26 INFO - TEST-START | kraken 15:53:26 INFO - operating with platform_type : linux_ 15:53:26 INFO - Initialising browser for kraken test... 15:53:26 INFO - TEST-INFO | started process 3232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj3IHjx/profile http://localhost:55034/getInfo.html) 15:53:31 INFO - PROCESS | 3232 | __metrics Screen width/height:1600/1200 15:53:31 INFO - PROCESS | 3232 | colorDepth:24 15:53:31 INFO - PROCESS | 3232 | Browser inner width/height: 1024/697 15:53:31 INFO - PROCESS | 3232 | __metrics 15:53:31 ERROR - PROCESS | 3232 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 15:53:32 INFO - TEST-INFO | 3232: exit 0 15:53:32 INFO - Browser initialized. 15:53:32 INFO - Running cycle 1/1 for kraken test... 15:53:32 INFO - TEST-INFO | started process 3361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj3IHjx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:44 INFO - PROCESS | 3361 | RSS: Main: 153956352 15:53:44 INFO - PROCESS | 3361 | 15:53:46 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-beat-detection) 15:53:47 INFO - PROCESS | 3361 | RSS: Main: 159764480 15:53:47 INFO - PROCESS | 3361 | 15:53:50 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-dft) 15:53:51 INFO - PROCESS | 3361 | RSS: Main: 158826496 15:53:51 INFO - PROCESS | 3361 | 15:53:53 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-fft) 15:53:54 INFO - PROCESS | 3361 | RSS: Main: 159789056 15:53:54 INFO - PROCESS | 3361 | 15:53:56 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55034/tests/kraken/driver.html?testName=audio-oscillator) 15:53:57 INFO - PROCESS | 3361 | RSS: Main: 158883840 15:53:57 INFO - PROCESS | 3361 | 15:53:59 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:00 INFO - PROCESS | 3361 | RSS: Main: 158380032 15:54:00 INFO - PROCESS | 3361 | 15:54:03 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55034/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:03 INFO - PROCESS | 3361 | RSS: Main: 158748672 15:54:03 INFO - PROCESS | 3361 | 15:54:07 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55034/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:07 INFO - PROCESS | 3361 | RSS: Main: 159162368 15:54:07 INFO - PROCESS | 3361 | 15:54:10 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55034/tests/kraken/driver.html?testName=json-parse-financial) 15:54:11 INFO - PROCESS | 3361 | RSS: Main: 159125504 15:54:11 INFO - PROCESS | 3361 | 15:54:12 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:13 INFO - PROCESS | 3361 | RSS: Main: 159076352 15:54:13 INFO - PROCESS | 3361 | 15:54:15 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:15 INFO - PROCESS | 3361 | RSS: Main: 159387648 15:54:15 INFO - PROCESS | 3361 | 15:54:17 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:18 INFO - PROCESS | 3361 | RSS: Main: 159674368 15:54:18 INFO - PROCESS | 3361 | 15:54:21 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:21 INFO - PROCESS | 3361 | RSS: Main: 160227328 15:54:21 INFO - PROCESS | 3361 | 15:54:24 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:24 INFO - PROCESS | 3361 | RSS: Main: 159928320 15:54:24 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | Cycle 1(1): loaded http://localhost:55034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55034/tests/kraken/driver.html?testName=ai-astar) 15:54:26 INFO - PROCESS | 3361 | RSS: Main: 160534528 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | __start_tp_report 15:54:26 INFO - PROCESS | 3361 | _x_x_mozilla_page_load 15:54:26 INFO - PROCESS | 3361 | _x_x_mozilla_page_load_details 15:54:26 INFO - PROCESS | 3361 | |i|pagename|runs| 15:54:26 INFO - PROCESS | 3361 | |0;ai-astar;111;105;112;112;112;113;112;111;111;112 15:54:26 INFO - PROCESS | 3361 | |1;audio-beat-detection;153;124;156;184;128;165;159;135;186;131 15:54:26 INFO - PROCESS | 3361 | |2;audio-dft;167;166;162;162;163;163;162;164;163;161 15:54:26 INFO - PROCESS | 3361 | |3;audio-fft;77;74;76;168;76;75;75;75;180;76 15:54:26 INFO - PROCESS | 3361 | |4;audio-oscillator;85;84;151;92;87;87;134;85;85;140 15:54:26 INFO - PROCESS | 3361 | |5;imaging-gaussian-blur;118;118;118;119;118;117;119;118;117;118 15:54:26 INFO - PROCESS | 3361 | |6;imaging-darkroom;147;147;148;146;145;147;147;147;146;147 15:54:26 INFO - PROCESS | 3361 | |7;imaging-desaturate;95;95;96;95;96;96;95;97;95;97 15:54:26 INFO - PROCESS | 3361 | |8;json-parse-financial;52;54;54;54;55;54;56;55;53;55 15:54:26 INFO - PROCESS | 3361 | |9;json-stringify-tinderbox;59;59;61;59;60;59;59;60;59;60 15:54:26 INFO - PROCESS | 3361 | |10;stanford-crypto-aes;75;75;81;79;76;83;77;78;98;83 15:54:26 INFO - PROCESS | 3361 | |11;stanford-crypto-ccm;126;118;126;129;131;121;147;137;120;123 15:54:26 INFO - PROCESS | 3361 | |12;stanford-crypto-pbkdf2;156;159;153;157;156;154;155;154;152;155 15:54:26 INFO - PROCESS | 3361 | |13;stanford-crypto-sha256-iterative;63;64;68;61;61;62;66;61;62;60 15:54:26 INFO - PROCESS | 3361 | __end_tp_report 15:54:26 INFO - PROCESS | 3361 | __start_cc_report 15:54:26 INFO - PROCESS | 3361 | _x_x_mozilla_cycle_collect,852 15:54:26 INFO - PROCESS | 3361 | __end_cc_report 15:54:26 INFO - PROCESS | 3361 | __startTimestamp1470005666889__endTimestamp 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | ------- Summary: start ------- 15:54:26 INFO - PROCESS | 3361 | Number of tests: 14 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.23 (2.0%) stddev-sans-first:2.37 15:54:26 INFO - PROCESS | 3361 | Values: 111.0 105.0 112.0 112.0 112.0 113.0 112.0 111.0 111.0 112.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:157.50 stddev:22.37 (14.2%) stddev-sans-first:23.73 15:54:26 INFO - PROCESS | 3361 | Values: 153.0 124.0 156.0 184.0 128.0 165.0 159.0 135.0 186.0 131.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.89 (1.2%) stddev-sans-first:1.45 15:54:26 INFO - PROCESS | 3361 | Values: 167.0 166.0 162.0 162.0 163.0 163.0 162.0 164.0 163.0 161.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.50 stddev:41.64 (55.1%) stddev-sans-first:43.64 15:54:26 INFO - PROCESS | 3361 | Values: 77.0 74.0 76.0 168.0 76.0 75.0 75.0 75.0 180.0 76.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:27.08 (31.9%) stddev-sans-first:27.93 15:54:26 INFO - PROCESS | 3361 | Values: 85.0 84.0 151.0 92.0 87.0 87.0 134.0 85.0 85.0 140.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 15:54:26 INFO - PROCESS | 3361 | Values: 118.0 118.0 118.0 119.0 118.0 117.0 119.0 118.0 117.0 118.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 15:54:26 INFO - PROCESS | 3361 | Values: 147.0 147.0 148.0 146.0 145.0 147.0 147.0 147.0 146.0 147.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 15:54:26 INFO - PROCESS | 3361 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 95.0 97.0 95.0 97.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.14 (2.1%) stddev-sans-first:0.88 15:54:26 INFO - PROCESS | 3361 | Values: 52.0 54.0 54.0 54.0 55.0 54.0 56.0 55.0 53.0 55.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 15:54:26 INFO - PROCESS | 3361 | Values: 59.0 59.0 61.0 59.0 60.0 59.0 59.0 60.0 59.0 60.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:6.84 (8.5%) stddev-sans-first:6.95 15:54:26 INFO - PROCESS | 3361 | Values: 75.0 75.0 81.0 79.0 76.0 83.0 77.0 78.0 98.0 83.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:127.50 stddev:8.80 (6.9%) stddev-sans-first:9.31 15:54:26 INFO - PROCESS | 3361 | Values: 126.0 118.0 126.0 129.0 131.0 121.0 147.0 137.0 120.0 123.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.50 stddev:2.02 (1.3%) stddev-sans-first:2.12 15:54:26 INFO - PROCESS | 3361 | Values: 156.0 159.0 153.0 157.0 156.0 154.0 155.0 154.0 152.0 155.0 15:54:26 INFO - PROCESS | 3361 | 15:54:26 INFO - PROCESS | 3361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:2.53 (4.0%) stddev-sans-first:2.68 15:54:26 INFO - PROCESS | 3361 | Values: 63.0 64.0 68.0 61.0 61.0 62.0 66.0 61.0 62.0 60.0 15:54:26 INFO - PROCESS | 3361 | -------- Summary: end -------- 15:54:26 INFO - PROCESS | 3361 | 15:54:27 INFO - TEST-INFO | 3361: exit 0 15:54:27 INFO - TEST-OK | kraken | took 61247ms 15:54:27 INFO - SUITE-END | took 1171s 15:54:28 INFO - Completed test suite (00:19:31) 15:54:28 INFO - javascript benchmark 15:54:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7601.736106379051, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.098983274516, 3359.9496007559883, 3366.966330336696, 3384.8984530464095, 3387.508811222371, 5516.7517461714215, 5563.248961390211, 5584.441555844413, 5604.1593760935775, 5634.802781902634, 5636.18275350074, 5665.263515742958, 5667.376588575254, 5668.603197776158, 5687.203791469197, 5043.697378157322, 5124.795008199686, 5167.741612919339, 5195.168772996321, 5199.818006369778, 5051.9494805051845, 5054.444011158769, 5099.031184075033, 5199.948000519984, 5208.635395522315, 5113.744312784346, 5117.641765076446, 5123.2315152727015, 5127.717975511346, 5134.563562097226, 5105.84682459525, 5195.922061169085, 5198.142306519419, 5205.661631993946, 5241.9213711794355, 4927.876803079916, 5018.247262910592, 5085.644004919657, 5153.458886816868, 5163.1480805667015, 5378.300820893298, 5432.022235997519, 5443.42844001382, 5471.343438787331, 5496.285482887239, 5938.257717785277, 5980.192673989043, 5980.790672326491, 5989.071693887455, 5990.251218597676, 5868.735906884201, 5951.791687290924, 6055.303640081403, 6057.151998720183, 6071.787487437919, 5562.805301814417, 5672.5178359839465, 5682.318121825366, 5683.090705487143, 5716.857078573027, 6159.353267906805, 6159.784407545714, 6164.137020817089, 6164.845878853064, 6180.072989051679, 5704.401037890962, 5759.136129580513, 5812.186293918855, 5929.258842644669, 5949.970250148808, 5958.404159584094, 5964.373740757244, 5975.790847320323, 5977.910331345033, 5999.310079340845, 5855.765769369177, 5916.792912248136, 5929.9110513341475, 5976.372480889531, 5980.521558275327, 5827.271591051119, 5866.941330586725, 5868.061110222344, 5920.585559010828, 5992.520598352121, 4584.33527138563, 4594.540545945379, 4598.471175814824, 4599.9080018399445, 4614.815407383667, 4125.752454852718, 4143.129942712064, 4150.315197992298, 4157.210130075276, 4167.791610419527, 5635.070213414822, 5752.3097228332035, 5753.05074662676, 5766.711664416763, 5807.970960145257, 5865.67738774363, 5917.349091599921, 5929.792457263975, 6009.609375390585, 6039.456448919531, 5641.182028605829, 5742.109972954198, 5763.538916886639, 5777.913331300034, 5778.855528611734, 5165.612579056586, 5177.249298851645, 5186.170212765939, 5211.140161873324, 5219.243209734567, 6245.500359971192, 6246.312905580383, 6270.561060725797, 6300.527460440394, 6332.905006424908, 5889.52883769306, 5969.641821490724, 6012.338642749294, 6030.185924900258, 6037.849053773691, 6167.290761562478, 6296.496280297473, 6296.653684047421, 6302.338254483213, 6318.462930650946, 5951.285845698544, 5960.105984102246, 5963.165156878127, 5964.701764911824, 5998.580099393001, 5899.439553242435, 5920.79277225295, 5997.100434934795, 6037.305709843248, 6060.060690592965, 5939.970300148471, 5946.494547963472, 5957.255343082114, 5961.821145365646, 5970.910436343372, 5879.823605291848, 5913.58604897653, 5916.73374698131, 5928.49607783326, 5944.3164036136395, 5669.6314739541795, 5694.686792226467, 5697.003024470619, 5763.164341170591, 5764.827055188351, 5808.5062769665055, 5858.2677165354335, 5888.057910734262, 5904.3210030847, 5905.084711869667, 5755.769769209185, 5760.423957604374, 5776.768929242783, 5778.248827652378, 5787.131930210502], "value": 5543.871943378236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9085641725534, 644.8001119652907, 650.7039297119811, 651.1372431528226, 662.0929326822254, 44880.32679509806, 46124.308135377956, 46340.768296158516, 46596.0, 50111.24833127497, 46898.53101468984, 46971.0, 47049.529504704944, 47501.52498475014, 47626.285605715944, 8974.820503589941, 9111.68109116181, 9133.36066475347, 9138.99471058183, 9142.588583513758, 8954.86567701485, 9005.054469280729, 9028.32287578431, 9051.818963620724, 9071.41035832672, 9028.68399606014, 9056.909430905673, 9096.681616143436, 9113.908860911371, 9114.225290850252, 9016.188543031127, 9062.410943288698, 9076.546172691338, 9094.136057074567, 9112.772180695469, 8914.86627700585, 8952.283817294601, 8968.103189681045, 8972.371933964625, 8998.370114092017, 44958.32562511565, 45575.54424455746, 45595.77202113968, 45599.0, 45827.31259031117, 3700.389435743099, 3868.7485313454536, 3927.136030073379, 4083.591640835922, 4126.938095928564, 34581.481277780855, 34648.65351346479, 34861.651383486096, 34991.475127873106, 35215.647843521496, 4705.294205869112, 4763.3807605011125, 4785.712857228577, 4808.975955120237, 4828.37231159947, 365691.0, 366683.0, 366847.9999999973, 370529.0, 370567.0, 56655.43344566584, 61911.380886191466, 61998.38001619926, 62189.0, 62431.6878415605, 38545.61454385476, 39676.20647587032, 39900.40149397762, 65326.673366632866, 65433.0, 19475.707864382046, 19530.70703939442, 19557.804421955883, 19653.901730491543, 19743.703844442345, 14847.0, 14941.551753447415, 14993.850061499244, 15028.17345046033, 15052.0, 20864.47838804042, 20909.895450522956, 20971.8951405242, 21058.578828423346, 21120.366389008355, 7342.192358840523, 7597.392208623297, 7637.198094200029, 7696.345810606162, 7887.921120788834, 965.7199412170532, 1072.7961687279549, 1094.6715985204567, 1175.2360965372577, 1183.7632473505162, 32892.50661240083, 33182.170445738564, 33198.66801332004, 33539.0, 33554.83222583871, 1140.0822338017974, 1156.1444531047132, 1157.484919210943, 1171.9062475001979, 1192.8389667394965, 17246.65506689859, 17604.735928961076, 17709.29162833498, 17743.467695969142, 17764.289428422977, 590471.0, 616923.0, 622931.0, 626396.0, 858066.0, 63292.68353658202, 63782.0, 63886.0, 63948.36051639517, 64203.35796642067, 1477.416420513891, 1507.4723846653803, 1511.8185817701726, 1523.8875620797103, 1528.2893454543691, 32567.511487328182, 32791.18022049468, 33139.50290745593, 33227.0, 33942.0, 54748.0, 60637.69681151566, 60825.69587152036, 60846.391536085845, 60923.0, 533105.0, 535070.0, 538109.0, 538378.0, 538600.0, 30079.548806768355, 31224.375512490078, 31270.53094203634, 32110.67889321077, 45422.77288613536, 50867.491325086274, 51430.22854657108, 51628.483715162365, 51740.74129629328, 52799.47200527946, 42899.57100428956, 43308.566914330455, 43310.56689433065, 43793.562064380225, 43833.78083109564, 41311.173776524905, 44373.0, 45278.0, 45316.32025519554, 46292.30561541512, 42318.36522452227, 43922.78038609914, 44705.776471118734, 44836.77581612071, 44863.55136448724, 37095.25809483849, 38251.23497529978, 38678.41982370323, 39343.80328098341, 39555.40666889941, 29434.705652944052, 29771.55342669905, 29789.702102978692, 30102.24744381408, 30273.848630756704], "value": 21646.102166225843, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.3374468340023, 425.44904348868215, 426.07329059296035, 434.25091716788523, 444.81540160833254, 18297.17662705178, 19133.139008744623, 19951.0, 20796.272130475438, 20813.16747330105, 19440.61118777627, 19521.902390488063, 19849.603007939833, 20178.0, 20225.898870505665, 5639.295088113976, 5757.050086735683, 5836.241288632493, 5842.970785146068, 5845.09401042839, 5612.607117501777, 5738.454846789548, 5780.884382312352, 5783.248177736909, 5862.736176872029, 5790.913136302959, 5795.507381872546, 5805.883882322351, 5806.071028635419, 5808.709564521778, 5627.296587926509, 5777.451142141511, 5797.507211886995, 5832.0, 5843.970780146094, 5199.584033277329, 5211.1922651989, 5215.452377500345, 5240.554552863011, 5253.553447956928, 22344.664830027563, 23086.53826923469, 23356.53286934269, 23368.53262934732, 23587.764122358727, 2497.4505608766044, 2612.4644447888327, 2628.566286562715, 2649.112547296658, 2864.7851411144247, 10004.54979525923, 10248.23138264633, 10547.208959328082, 10712.571497140105, 10816.945915270373, 2053.16846677096, 2132.243053715924, 2136.7115439415634, 2160.837937154704, 2211.1487077475126, 66791.0, 76843.61578192073, 88554.55722721345, 89732.17173249967, 91897.54051229768, 11189.0, 11473.598424055119, 11513.769724605461, 11519.769604607862, 11668.88331116695, 16392.508224753277, 16400.75398869018, 16423.260953257133, 16537.586560335847, 16545.66908661844, 8928.10718928102, 8933.374663773473, 9010.234130099016, 9047.592858321392, 9114.316426268057, 8937.776555586162, 8971.282297416321, 8976.147266009719, 9017.368784185044, 9093.727188184364, 4644.698094623838, 4832.395950506187, 4951.405831300267, 4972.7513624318635, 4985.725785081855, 1941.213808407597, 2001.7998200180157, 2024.9898750506154, 2067.700183473388, 2144.3995681209285, 962.1917589225085, 1009.1069403577886, 1024.4109636958779, 1098.9230753847314, 1110.74452875839, 17250.913745431444, 17885.105744712713, 18452.90773546124, 19170.71243931342, 19272.710909336372, 1039.7608550033535, 1051.8422236664562, 1056.2447849787438, 1081.324172392255, 1083.2200815412891, 10297.742556436, 10676.359418434919, 10732.570697172181, 10757.784844303227, 10855.0, 506701.0, 513234.0, 513932.0, 518955.0, 525624.0, 70546.294537055, 94541.5272923631, 96360.0, 97045.51477242568, 98142.0, 978.3396207559869, 1083.2146693647044, 1084.1706094837455, 1084.7125511739396, 1085.4193006741355, 17291.740623890902, 17457.0, 17476.388326408516, 17525.47423577295, 17739.73390399171, 37937.24125517529, 39229.215415692095, 40215.597844022355, 40289.79855100706, 42652.0, 53257.46742532525, 54776.452235478726, 60691.39308607034, 63120.68439657772, 63782.3621763795, 8046.557439340892, 8152.9184708154535, 8260.752177434686, 8289.626966786629, 8613.612387442705, 11921.642350729491, 13006.739865202831, 13073.542426015043, 13387.196768193939, 13688.31558422055, 5697.715114244188, 9043.728688139367, 10251.333663311862, 10669.35983840972, 10783.6225732099, 11451.59919402817, 11507.884921150682, 11638.6508404748, 11836.289822610672, 11940.164188506722, 8309.335253179852, 10827.0, 10998.230123891251, 11134.777304454028, 11185.384803835866, 7527.059117610299, 7704.961475192588, 7897.328727058264, 8107.432479726598, 8830.514321712368, 10509.842352364874, 10874.782504350027, 10962.725931851768, 10964.725881853017, 11034.779304414027], "value": 9329.527413971371, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.9922550387246, 1566.7336552786026, 1786.428342930263, 1871.9532011699714, 1913.502489352768, 8059.91940080599, 8642.0, 8651.0, 9214.723558293244, 9226.0, 8721.781955451117, 8964.148405901446, 9009.639614415415, 9017.368784185093, 9062.184403403693, 2420.3465064432594, 2428.76926691964, 2444.706635203778, 2454.5949918263464, 2465.950680986379, 2398.352444839892, 2416.5650182967147, 2445.9021639134503, 2448.424620214248, 2455.0179928028842, 2392.35406440261, 2397.808175345977, 2405.6632071510003, 2411.3248290478696, 2413.987930060347, 2328.604137296664, 2342.8828558572172, 2347.80043696286, 2351.823613229015, 2366.1718398560365, 2314.664373665809, 2364.219807463533, 2395.6646069550275, 2403.086827005744, 2405.302462285935, 9063.274938004944, 9097.909020909772, 9158.17576418119, 9164.037776033554, 9181.449113053171, 5397.190421436777, 5434.239206511092, 5470.6444081135, 5505.146702261156, 5516.200150978086, 3542.3800834854055, 3571.4642803579673, 3588.4617307403837, 3633.3278343506536, 3678.926421471582, 1242.4781591731494, 1253.3419954523856, 1267.1256832785348, 1268.391172237322, 1285.3637449462576, 12365.38173091342, 12497.812532812015, 12519.874801251963, 12539.749205015849, 12558.74882502354, 4697.084068606658, 4697.224957881979, 4806.086843499724, 4812.5668689818085, 4843.491433399513, 10672.30630009047, 10711.143108551298, 10729.088027517591, 10734.033936945712, 10743.946280268548, 5462.863428414242, 5463.672179669233, 5501.697406642593, 5506.394296627368, 5529.087700529368, 4457.68796184264, 4861.951380486221, 5022.59819214462, 5026.924596131061, 5082.949170508322, 4146.91706165881, 4200.3699445082875, 4203.873883783492, 4276.764777937244, 4425.513193548707, 1277.495389321213, 1290.2967882504058, 1306.324680880699, 1313.1398933698442, 1318.2090745552591, 862.8188080503039, 879.160401816264, 958.1711819276276, 989.7970915962211, 1030.0883717909553, 6252.468540174136, 6262.499000079983, 6282.717277722513, 6287.748490060347, 6293.056041593798, 474.2625217786375, 478.7103802199689, 480.1117931826094, 488.57738056581513, 489.080528606218, 4299.849505267301, 4422.226110430726, 4519.751413672214, 4537.75042372666, 4557.065801510682, 10559.524821383056, 10811.35131892089, 10830.945845270724, 10890.564377424973, 10891.509882055168, 10386.584536618602, 10673.199510036779, 10729.302595331279, 10738.087262582612, 10754.516046777913, 8363.0, 8502.234798868132, 8508.659653613786, 8516.914830851612, 8568.314534837198, 5933.881322373615, 5934.732937017931, 6089.969550152221, 6147.66187859672, 6206.813795585959, 9931.851022234529, 10024.749381265236, 10050.09549140581, 10092.091711745978, 10170.898291016994, 10334.224933129895, 10592.0, 10609.0, 10631.574737010433, 10728.51721672511, 6847.486438517031, 7959.761207163794, 7993.520388776692, 8086.272235498834, 8127.146649601943, 8824.11758824138, 8861.379703420698, 8889.333300002654, 8910.108989101038, 8912.86630700553, 7982.201779821971, 8137.064237612751, 8169.5506747129475, 8240.62917168717, 8302.252797248277, 7719.266669666373, 7838.098618658927, 7843.450958432855, 7850.842983140419, 7957.482763620346, 7193.964030179815, 7215.891761623475, 7229.855402892018, 7292.744753933587, 7299.124105107421, 5471.343438787371, 5475.123980163155, 5502.422245664147, 5518.392976772471, 5544.7782088716, 5319.840404787863, 5357.70532620694, 5394.9460505394445, 5435.429279925551, 5579.553635709215], "value": 4718.846001137887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3007659489535, 348.445970906259, 349.6189153822333, 350.479537886239, 352.7283991326678, 5756.618411581222, 5791.594588378815, 5797.333306669734, 5820.53435725142, 5829.213056237407, 5740.655560666352, 5751.396103409144, 5773.076307790754, 5786.68173250471, 5789.652620842752, 4102.282100632392, 4402.779861006953, 4407.559244075599, 4431.88920276994, 4453.28747400416, 4402.339649052652, 4421.867343979686, 4446.177457170417, 4451.866444006685, 4466.173757854791, 4426.44669416323, 4428.0, 4435.090806384699, 4464.531224221459, 4467.910641787163, 4280.74315541067, 4398.868033958986, 4403.075354175627, 4405.251107311765, 4424.690271680984, 3927.705422093326, 3952.505936757905, 3955.564887862333, 3965.4250133730734, 3969.6824254059607, 5445.700486473243, 5470.617056806025, 5478.58910581704, 5495.148252020943, 5508.127236739528, 4859.659823812334, 4995.550400463976, 5063.670861393997, 5089.592832573385, 5090.898182036375, 5942.197803296586, 5943.762249510014, 5955.702214889238, 5967.970160149215, 5972.223610930595, 4185.727927684691, 4229.154169166179, 4230.344296634026, 4249.4475718156755, 4263.616274535307, 6002.669853158074, 6148.84627884302, 6180.845478863064, 6208.348123447018, 6212.378762123797, 4222.345536441856, 4230.450041494648, 4231.217224813419, 4236.639885609696, 4271.508776490681, 4315.8489452869, 4328.956710432918, 4336.674749393808, 4344.45694288214, 4360.084382279757, 4911.877203069952, 5005.822467226768, 5009.749512524432, 5011.57401620859, 5017.397912250553, 5996.4603185713495, 6018.15745795589, 6034.172661870486, 6036.3058248302, 6041.365656606081, 1481.3111902965172, 1510.9800884402985, 1512.8714059304862, 1534.907905525672, 1541.2370876416246, 944.3059351376733, 1023.0459821740588, 1041.6874937518864, 1043.5564884924029, 1050.9159267258601, 5847.181394604759, 5885.61743486672, 5945.7621695132575, 5947.256592925884, 5960.254968128984, 6161.106639537332, 6189.659568723763, 6195.256569211723, 6195.907061394083, 6232.750689972441, 5595.692236927008, 5824.893270278633, 5900.527957763368, 5924.31870334917, 5928.318243401977, 3254.5280934264397, 3299.884504042347, 3301.1747063234193, 3307.5534802801794, 3319.7344212462945, 6260.116038745949, 6461.644609546426, 6465.903011454832, 6507.8698426031215, 6509.446697030806, 6333.050042493663, 6354.205724284465, 6364.6316042051185, 6387.201599800025, 6391.872162556816, 6136.8772624547255, 6488.545801793829, 6504.219493660886, 6521.510886683518, 6528.869422611616, 6197.411245931629, 6222.191115155001, 6238.968805155945, 6243.937560624336, 6282.277538082996, 6042.093685947143, 6120.265568131853, 6126.417990290915, 6167.660778657217, 6168.753249869955, 6418.326075761977, 6475.740970361133, 6488.2538508072175, 6504.38208370204, 6504.739810407531, 4220.66234701217, 4271.060366719316, 4288.742675439484, 4292.849750258851, 4303.634191093792, 6044.848878778066, 6145.0, 6229.4393504584805, 6238.313785483684, 6298.1812364392335, 6041.78853740117, 6047.667378294236, 6068.4841788448475, 6108.938910610837, 6127.601705889103, 5881.38245484218, 6009.158717779427, 6010.459058684739, 6013.368596297326, 6049.7011135768125, 5808.970955145197, 5927.288725352985, 5946.226990491208, 5960.374160713062, 5970.223870896755, 6123.418275263843, 6131.872744900223, 6133.478654314434, 6134.466383404149, 6204.224471941007, 5846.619969701956, 5953.791617293374, 5974.1636170935235, 5976.462118409364, 6011.849703757441], "value": 4578.904428621743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.19196419652, 801.2548330053052, 804.4610111225478, 871.7689812199767, 892.081156408899, 16574.502764917055, 17458.738118928228, 17480.125993700294, 17504.91247543762, 17601.295948162075, 16132.112733799666, 16192.0, 16271.186440677979, 16281.83718162818, 16321.918390408062, 706.7985624097107, 846.4836449765638, 847.745676297113, 875.7504111328273, 877.9912200878006, 864.654138344664, 866.0084203586889, 867.2584939876378, 867.8524650809346, 873.1181506678269, 925.4771054354302, 926.036921601537, 926.1340646495514, 926.5598840550751, 927.8747369105185, 919.0992827029515, 922.1424075609681, 925.4586067150691, 925.5788616179622, 926.7775733823901, 669.7354544954716, 671.0906721392491, 671.67088126818, 673.4309508465338, 675.0178490296655, 15090.39638414462, 15104.848951510454, 15140.091594504365, 15157.014794038352, 15208.619784505365, 15237.847621523753, 16187.19064046793, 16636.08501532415, 16636.916815415967, 16648.0, 12368.628941131781, 12372.257664540157, 13584.932075339659, 13718.314084295846, 13921.721565568632, 4734.763261836894, 4789.090072886141, 4863.513648635144, 4892.168331383637, 4898.24077268024, 78044.60977695131, 78293.60853195812, 79111.604441978, 79370.0, 79926.0, 12234.449449774782, 12298.815517767242, 12301.507939682313, 12336.0, 12460.75078498425, 21429.67855482169, 21595.460113497287, 21637.0, 21719.457013574785, 21736.456588585414, 8897.955510222408, 8961.596728147118, 9011.63953441855, 9147.817043659223, 9156.496392698466, 5112.079825631347, 5216.504432078947, 5260.210968354778, 5302.602304827076, 5351.705656188947, 3557.7331700122595, 3671.706263498967, 3672.5225720656144, 3674.228412033503, 3678.0620941659704, 642.6465444005871, 643.9388258115472, 644.1239913717341, 650.2944305428568, 661.4609093588709, 685.3283781893672, 719.3022767915114, 722.360710770961, 734.0494060192065, 735.7902997645646, 9755.512224388753, 10035.598576056876, 10062.597496100074, 10090.848637270446, 10111.241656875764, 757.4394947738633, 774.2180397798264, 775.6276987046136, 779.8518281526492, 781.121403025724, 4684.789184486706, 4744.739039352799, 4822.7829747661435, 4864.586510146606, 4866.683665561727, 91526.54236728908, 114704.0, 114963.0, 119399.0, 119484.0, 92511.07488925025, 103112.48443757734, 104760.0, 104838.47580762047, 106613.0, 62364.0, 90180.0, 90386.09613903909, 90969.0, 91543.54228228817, 9397.637342585424, 9468.573914173741, 9493.145616894513, 9535.713928582154, 9545.570449329658, 36731.81634091919, 37243.62756372402, 50548.74725626349, 53747.0, 54901.725491372286, 67613.32386676071, 68132.0, 68356.65821671058, 68857.3114268871, 75739.24260757542, 13398.732025359242, 14130.364133613806, 14362.281885905453, 14571.198584077554, 14776.63058423505, 15217.239138043275, 15223.695526089195, 15317.157556334509, 16321.918390407973, 16503.422380216634, 14685.48600798967, 15046.32291546861, 15248.31382587764, 15456.92271538635, 15668.529944101696, 13799.172049677052, 14106.2946852659, 14310.212938288494, 14356.856431435552, 14858.0, 13265.933670331586, 13267.33663316811, 13692.794608080687, 13721.108127971649, 13754.587362379145, 11921.957422290161, 12032.578859739868, 12269.509219631114, 12365.443555040225, 12379.257244565355, 11545.595904143314, 12399.194052386567, 12591.181573197713, 12622.0, 12683.619491415273], "value": 7975.966577862608, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 112.0, 112.0, 112.0, 113.0, 112.0, 111.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 156.0, 184.0, 128.0, 165.0, 159.0, 135.0, 186.0, 131.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 162.0, 162.0, 163.0, 163.0, 162.0, 164.0, 163.0, 161.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 168.0, 76.0, 75.0, 75.0, 75.0, 180.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 151.0, 92.0, 87.0, 87.0, 134.0, 85.0, 85.0, 140.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 119.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 145.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0, 97.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 54.0, 54.0, 55.0, 54.0, 56.0, 55.0, 53.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 81.0, 79.0, 76.0, 83.0, 77.0, 78.0, 98.0, 83.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 118.0, 126.0, 129.0, 131.0, 121.0, 147.0, 137.0, 120.0, 123.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 153.0, 157.0, 156.0, 154.0, 155.0, 154.0, 152.0, 155.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 68.0, 61.0, 61.0, 62.0, 66.0, 61.0, 62.0, 60.0], "value": 62.8, "unit": "score"}]}]} 15:54:28 INFO - Return code: 0 15:54:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:28 ERROR - # TBPL SUCCESS # 15:54:28 INFO - Running post-action listener: _resource_record_post_action 15:54:28 INFO - ##### 15:54:28 INFO - ##### Finished run-tests step (success) 15:54:28 INFO - ##### 15:54:28 INFO - Running post-run listener: _resource_record_post_run 15:54:28 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 294912; Write bytes: 492290048; Read time: 52; Write time: 314256 15:54:28 INFO - TinderboxPrint: CPU usage
13.3% 15:54:28 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 52 15:54:28 INFO - TinderboxPrint: I/O write bytes / time
492,290,048 / 314,256 15:54:28 INFO - TinderboxPrint: CPU idle
8,214.3 (86.7%) 15:54:28 INFO - TinderboxPrint: CPU user
1,211.1 (12.8%) 15:54:28 INFO - TinderboxPrint: Swap in / out
0 / 0 15:54:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242630656; Read time: 0; Write time: 196780 15:54:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 270336; Write bytes: 249659392; Read time: 36; Write time: 117476 15:54:28 INFO - Running post-run listener: _upload_blobber_files 15:54:28 INFO - Blob upload gear active. 15:54:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:28 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 15:54:28 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:54:28 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:54:29 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:54:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:30 INFO - (blobuploader) - INFO - Done attempting. 15:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:30 INFO - (blobuploader) - INFO - Done attempting. 15:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:34 INFO - (blobuploader) - INFO - Done attempting. 15:54:34 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:34 INFO - Return code: 0 15:54:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b358f292f670a961dbf4a2ad44c8e48d4203913a730362167fd0f44f41c40f2ac34c9d2157521cc2db5fa1774d9816aebf82f13d22cf083044d391129c1cb8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50611c9ec49aa120b2feb381410a58c6df6cb796b4fafc6d37189db5e808e173a392b3b21312500166edabb860c3c5dea7d0baf99cf29aa66aa69c23915ca932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512fc27bd50867fdb2ea7009fa3b2bc264cb47cb19b88911485a5b5e3d85316c06729580e2a5ebfbc0b1989fe0644379cf84e9db13f068384d027ac94a4bb392"} 15:54:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:34 INFO - Contents: 15:54:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b358f292f670a961dbf4a2ad44c8e48d4203913a730362167fd0f44f41c40f2ac34c9d2157521cc2db5fa1774d9816aebf82f13d22cf083044d391129c1cb8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50611c9ec49aa120b2feb381410a58c6df6cb796b4fafc6d37189db5e808e173a392b3b21312500166edabb860c3c5dea7d0baf99cf29aa66aa69c23915ca932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512fc27bd50867fdb2ea7009fa3b2bc264cb47cb19b88911485a5b5e3d85316c06729580e2a5ebfbc0b1989fe0644379cf84e9db13f068384d027ac94a4bb392"} 15:54:34 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:34 INFO - Copying logs to upload dir... 15:54:34 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.130301 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-31 15:54:34.003207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 15:54:34.006796) ========= 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=00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b358f292f670a961dbf4a2ad44c8e48d4203913a730362167fd0f44f41c40f2ac34c9d2157521cc2db5fa1774d9816aebf82f13d22cf083044d391129c1cb8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50611c9ec49aa120b2feb381410a58c6df6cb796b4fafc6d37189db5e808e173a392b3b21312500166edabb860c3c5dea7d0baf99cf29aa66aa69c23915ca932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512fc27bd50867fdb2ea7009fa3b2bc264cb47cb19b88911485a5b5e3d85316c06729580e2a5ebfbc0b1989fe0644379cf84e9db13f068384d027ac94a4bb392"} build_url:https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/QLyEpgBmQ7a4hIGyAf1oaQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b358f292f670a961dbf4a2ad44c8e48d4203913a730362167fd0f44f41c40f2ac34c9d2157521cc2db5fa1774d9816aebf82f13d22cf083044d391129c1cb8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50611c9ec49aa120b2feb381410a58c6df6cb796b4fafc6d37189db5e808e173a392b3b21312500166edabb860c3c5dea7d0baf99cf29aa66aa69c23915ca932", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/512fc27bd50867fdb2ea7009fa3b2bc264cb47cb19b88911485a5b5e3d85316c06729580e2a5ebfbc0b1989fe0644379cf84e9db13f068384d027ac94a4bb392"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 15:54:34.031847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:54:34.032150) ========= 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=00204705a9daa57ed339a427000001b9-1470003615.358417-1661705513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 15:54:34.117018) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 15:54:34.117317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 15:54:34.117615) ========= ========= Total master_lag: 0.19 =========