builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1467325049.68 results: success (0) buildid: 20160630122127 builduid: ff240aa6a5f044299e52cd622baaa375 revision: cea38bcafb6ad58462496b582cec8eb361a727df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.678919) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.679406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.679711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.695297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.695712) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 15:17:29-- 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% 226M=0s 2016-06-30 15:17:29 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.821633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.821958) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017030 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.871453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:29.871828) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cea38bcafb6ad58462496b582cec8eb361a727df --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 cea38bcafb6ad58462496b582cec8eb361a727df --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=78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 15:17:29,890 truncating revision to first 12 chars 2016-06-30 15:17:29,890 Setting DEBUG logging. 2016-06-30 15:17:29,890 attempt 1/10 2016-06-30 15:17:29,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cea38bcafb6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 15:17:30,197 unpacking tar archive at: mozilla-aurora-cea38bcafb6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:30.547828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:30.548347) ========= script_repo_revision: cea38bcafb6ad58462496b582cec8eb361a727df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:30.549018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:30.549484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:17:30.561141) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-30 15:17:30.561739) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:17:30 INFO - MultiFileLogger online at 20160630 15:17:30 in /builds/slave/test 15:17:30 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:17:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:30 INFO - {'append_to_log': False, 15:17:30 INFO - 'base_work_dir': '/builds/slave/test', 15:17:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:17:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:30 INFO - 'branch': 'Mozilla-Aurora', 15:17:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:30 INFO - 'config_files': ('talos/linux_config.py',), 15:17:30 INFO - 'default_actions': ('clobber', 15:17:30 INFO - 'read-buildbot-config', 15:17:30 INFO - 'download-and-extract', 15:17:30 INFO - 'populate-webroot', 15:17:30 INFO - 'create-virtualenv', 15:17:30 INFO - 'install', 15:17:30 INFO - 'run-tests'), 15:17:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:30 INFO - 'download_minidump_stackwalk': True, 15:17:30 INFO - 'download_symbols': 'ondemand', 15:17:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:30 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:30 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:30 INFO - 'installer_path': 'installer.exe', 15:17:30 INFO - 'log_level': 'info', 15:17:30 INFO - 'log_name': 'talos', 15:17:30 INFO - 'log_to_console': True, 15:17:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:17:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:17:30 INFO - 'opt_config_files': (), 15:17:30 INFO - 'pip_index': False, 15:17:30 INFO - 'sps_profile': False, 15:17:30 INFO - 'sps_profile_interval': 0, 15:17:30 INFO - 'suite': 'dromaeojs-e10s', 15:17:30 INFO - 'system_bits': '32', 15:17:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:30 INFO - 'title': 'talos-linux64-ix-019', 15:17:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:30 INFO - 'use_talos_json': True, 15:17:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:30 INFO - 'work_dir': 'build'} 15:17:30 INFO - ##### 15:17:30 INFO - ##### Running clobber step. 15:17:30 INFO - ##### 15:17:30 INFO - Running pre-action listener: _resource_record_pre_action 15:17:30 INFO - Running main action method: clobber 15:17:30 INFO - rmtree: /builds/slave/test/build 15:17:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:31 INFO - Running post-action listener: _resource_record_post_action 15:17:31 INFO - ##### 15:17:31 INFO - ##### Finished clobber step (success) 15:17:31 INFO - ##### 15:17:31 INFO - ##### 15:17:31 INFO - ##### Running read-buildbot-config step. 15:17:31 INFO - ##### 15:17:31 INFO - Running pre-action listener: _resource_record_pre_action 15:17:31 INFO - Running main action method: read_buildbot_config 15:17:31 INFO - Using buildbot properties: 15:17:31 INFO - { 15:17:31 INFO - "project": "", 15:17:31 INFO - "product": "firefox", 15:17:31 INFO - "script_repo_revision": "production", 15:17:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:17:31 INFO - "repository": "", 15:17:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:17:31 INFO - "buildid": "20160630122127", 15:17:31 INFO - "pgo_build": "True", 15:17:31 INFO - "basedir": "/builds/slave/test", 15:17:31 INFO - "buildnumber": 384, 15:17:31 INFO - "slavename": "talos-linux64-ix-019", 15:17:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:17:31 INFO - "platform": "ubuntu64_hw", 15:17:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:17:31 INFO - "branch": "mozilla-aurora", 15:17:31 INFO - "repo_path": "releases/mozilla-aurora", 15:17:31 INFO - "revision": "cea38bcafb6ad58462496b582cec8eb361a727df", 15:17:31 INFO - "stage_platform": "linux64-pgo", 15:17:31 INFO - "builduid": "ff240aa6a5f044299e52cd622baaa375", 15:17:31 INFO - "slavebuilddir": "test" 15:17:31 INFO - } 15:17:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:17:31 INFO - Running post-action listener: _resource_record_post_action 15:17:31 INFO - ##### 15:17:31 INFO - ##### Finished read-buildbot-config step (success) 15:17:31 INFO - ##### 15:17:31 INFO - ##### 15:17:31 INFO - ##### Running download-and-extract step. 15:17:31 INFO - ##### 15:17:31 INFO - Running pre-action listener: _resource_record_pre_action 15:17:31 INFO - Running main action method: download_and_extract 15:17:31 INFO - mkdir: /builds/slave/test/build/tests 15:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:31 INFO - https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:31 INFO - Downloaded 1361 bytes. 15:17:31 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:17:31 INFO - Using the following test package requirements: 15:17:31 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:31 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:17:31 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:17:31 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'jsshell-linux-x86_64.zip'], 15:17:31 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:17:31 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:31 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:17:31 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:17:31 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:17:31 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:31 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:17:31 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:31 INFO - https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:17:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:32 INFO - Downloaded 24526463 bytes. 15:17:32 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:17:32 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:17:34 INFO - Return code: 0 15:17:34 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:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:34 INFO - https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:35 INFO - Downloaded 24526463 bytes. 15:17:35 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:17:35 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:17:36 INFO - Return code: 0 15:17: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:17:36 INFO - https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:37 INFO - Downloaded 10833369 bytes. 15:17:37 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:17:37 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:17:37 INFO - Return code: 0 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:17:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:17:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:17:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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:17:39 INFO - Downloaded 63600939 bytes. 15:17:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:17:39 INFO - mkdir: /builds/slave/test/properties 15:17:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:39 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:39 INFO - Contents: 15:17:39 INFO - build_url:https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:17:39 INFO - Running post-action listener: _resource_record_post_action 15:17:39 INFO - Running post-action listener: set_extra_try_arguments 15:17:39 INFO - ##### 15:17:39 INFO - ##### Finished download-and-extract step (success) 15:17:39 INFO - ##### 15:17:39 INFO - ##### 15:17:39 INFO - ##### Running populate-webroot step. 15:17:39 INFO - ##### 15:17:39 INFO - Running pre-action listener: _resource_record_pre_action 15:17:39 INFO - Running main action method: populate_webroot 15:17:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:39 INFO - '--tppagecycles', 15:17:39 INFO - '7'], 15:17:39 INFO - 'tests': ['tsvgm']}}, 15:17:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:17:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:17:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['damp', 'tps']}, 15:17:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'tests': ['damp', 'tps']}, 15:17:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['dromaeo_dom']}, 15:17:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other-e10s': {'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['tsvgx', 15:17:39 INFO - 'tsvgr_opacity', 15:17:39 INFO - 'tart', 15:17:39 INFO - 'tscrollx', 15:17:39 INFO - 'cart']}, 15:17:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:17:39 INFO - 'tsvgr_opacity', 15:17:39 INFO - 'tart', 15:17:39 INFO - 'tscrollx', 15:17:39 INFO - 'cart']}, 15:17:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--disable-e10s'], 15:17:39 INFO - 'tests': ['tp5o']}, 15:17:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'tests': ['tp5o']}, 15:17:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--disable-e10s', 15:17:39 INFO - '--xperf_path', 15:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:39 INFO - 'tests': ['tp5n']}, 15:17:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--xperf_path', 15:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:39 INFO - 'tests': ['tp5n']}}, 15:17:39 INFO - 'talos.zip': {'path': '', 15:17:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:39 INFO - Running post-action listener: _resource_record_post_action 15:17:39 INFO - ##### 15:17:39 INFO - ##### Finished populate-webroot step (success) 15:17:39 INFO - ##### 15:17:39 INFO - ##### 15:17:39 INFO - ##### Running create-virtualenv step. 15:17:39 INFO - ##### 15:17:39 INFO - Running pre-action listener: _resource_record_pre_action 15:17:39 INFO - Running main action method: create_virtualenv 15:17:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:39 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:17:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:40 INFO - Using real prefix '/usr' 15:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:42 INFO - Installing pip.................done. 15:17:42 INFO - Return code: 0 15:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17:42 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:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:42 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:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:42 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:17:42 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:17:42 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:17:42 INFO - Using env: {'DISPLAY': ':0', 15:17:42 INFO - 'HOME': '/home/cltbld', 15:17:42 INFO - 'LANG': 'en_US.UTF-8', 15:17:42 INFO - 'LANGUAGE': 'en_US:en', 15:17:42 INFO - 'LOGNAME': 'cltbld', 15:17:42 INFO - 'MAIL': '/var/mail/cltbld', 15:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:42 INFO - 'MOZ_NO_REMOTE': '1', 15:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:42 INFO - 'NO_EM_RESTART': '1', 15:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:42 INFO - 'PWD': '/builds/slave/test', 15:17:42 INFO - 'SHELL': '/bin/bash', 15:17:42 INFO - 'SHLVL': '1', 15:17:42 INFO - 'TERM': 'linux', 15:17:42 INFO - 'TMOUT': '86400', 15:17:42 INFO - 'USER': 'cltbld', 15:17:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:42 INFO - '_': '/tools/buildbot/bin/python'} 15:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:42 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:17:42 INFO - Cleaning up... 15:17:42 INFO - Return code: 0 15:17:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:17:42 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:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:42 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:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:42 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:17:42 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:17:42 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:17:42 INFO - Using env: {'DISPLAY': ':0', 15:17:42 INFO - 'HOME': '/home/cltbld', 15:17:42 INFO - 'LANG': 'en_US.UTF-8', 15:17:42 INFO - 'LANGUAGE': 'en_US:en', 15:17:42 INFO - 'LOGNAME': 'cltbld', 15:17:42 INFO - 'MAIL': '/var/mail/cltbld', 15:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:42 INFO - 'MOZ_NO_REMOTE': '1', 15:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:42 INFO - 'NO_EM_RESTART': '1', 15:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:42 INFO - 'PWD': '/builds/slave/test', 15:17:42 INFO - 'SHELL': '/bin/bash', 15:17:42 INFO - 'SHLVL': '1', 15:17:42 INFO - 'TERM': 'linux', 15:17:42 INFO - 'TMOUT': '86400', 15:17:42 INFO - 'USER': 'cltbld', 15:17:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:42 INFO - '_': '/tools/buildbot/bin/python'} 15:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:42 INFO - Downloading/unpacking psutil>=3.1.1 15:17:42 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:17:42 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:17:42 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:17:42 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:17:42 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:17:42 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:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:44 INFO - Installing collected packages: psutil 15:17:44 INFO - Running setup.py install for psutil 15:17:45 INFO - building 'psutil._psutil_linux' extension 15:17:45 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:17:45 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:17:45 INFO - building 'psutil._psutil_posix' extension 15:17:45 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:17:45 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:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:45 INFO - Successfully installed psutil 15:17:45 INFO - Cleaning up... 15:17:45 INFO - Return code: 0 15:17:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:45 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:17:45 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:17:45 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:17:45 INFO - Using env: {'DISPLAY': ':0', 15:17:45 INFO - 'HOME': '/home/cltbld', 15:17:45 INFO - 'LANG': 'en_US.UTF-8', 15:17:45 INFO - 'LANGUAGE': 'en_US:en', 15:17:45 INFO - 'LOGNAME': 'cltbld', 15:17:45 INFO - 'MAIL': '/var/mail/cltbld', 15:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:45 INFO - 'MOZ_NO_REMOTE': '1', 15:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:45 INFO - 'NO_EM_RESTART': '1', 15:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:45 INFO - 'PWD': '/builds/slave/test', 15:17:45 INFO - 'SHELL': '/bin/bash', 15:17:45 INFO - 'SHLVL': '1', 15:17:45 INFO - 'TERM': 'linux', 15:17:45 INFO - 'TMOUT': '86400', 15:17:45 INFO - 'USER': 'cltbld', 15:17:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:45 INFO - '_': '/tools/buildbot/bin/python'} 15:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:17:45 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:17:45 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:17:45 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:17:45 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:17:45 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:17:45 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:17:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:17:47 INFO - Installing collected packages: mozsystemmonitor 15:17:47 INFO - Running setup.py install for mozsystemmonitor 15:17:47 INFO - Successfully installed mozsystemmonitor 15:17:47 INFO - Cleaning up... 15:17:47 INFO - Return code: 0 15:17:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:47 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:17:47 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:17:47 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:17:47 INFO - Using env: {'DISPLAY': ':0', 15:17:47 INFO - 'HOME': '/home/cltbld', 15:17:47 INFO - 'LANG': 'en_US.UTF-8', 15:17:47 INFO - 'LANGUAGE': 'en_US:en', 15:17:47 INFO - 'LOGNAME': 'cltbld', 15:17:47 INFO - 'MAIL': '/var/mail/cltbld', 15:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:47 INFO - 'MOZ_NO_REMOTE': '1', 15:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:47 INFO - 'NO_EM_RESTART': '1', 15:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:47 INFO - 'PWD': '/builds/slave/test', 15:17:47 INFO - 'SHELL': '/bin/bash', 15:17:47 INFO - 'SHLVL': '1', 15:17:47 INFO - 'TERM': 'linux', 15:17:47 INFO - 'TMOUT': '86400', 15:17:47 INFO - 'USER': 'cltbld', 15:17:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:47 INFO - '_': '/tools/buildbot/bin/python'} 15:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:48 INFO - Downloading/unpacking jsonschema==2.5.1 15:17:48 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:17:48 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:17:48 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:17:48 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:17:48 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:17:48 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:17:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:17:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:17:50 INFO - warning: no files found matching '*.txt' 15:17:50 INFO - no previously-included directories found matching 'build' 15:17:50 INFO - no previously-included directories found matching 'dist' 15:17:50 INFO - no previously-included directories found matching '.git*' 15:17:50 INFO - Installing collected packages: jsonschema, functools32 15:17:50 INFO - Running setup.py install for functools32 15:17:50 INFO - warning: no files found matching '*.txt' 15:17:50 INFO - no previously-included directories found matching 'build' 15:17:50 INFO - no previously-included directories found matching 'dist' 15:17:50 INFO - no previously-included directories found matching '.git*' 15:17:50 INFO - Successfully installed jsonschema functools32 15:17:50 INFO - Cleaning up... 15:17:50 INFO - Return code: 0 15:17:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17:50 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:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:50 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:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:50 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:17:50 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:17:50 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:17:50 INFO - Using env: {'DISPLAY': ':0', 15:17:50 INFO - 'HOME': '/home/cltbld', 15:17:50 INFO - 'LANG': 'en_US.UTF-8', 15:17:50 INFO - 'LANGUAGE': 'en_US:en', 15:17:50 INFO - 'LOGNAME': 'cltbld', 15:17:50 INFO - 'MAIL': '/var/mail/cltbld', 15:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:50 INFO - 'MOZ_NO_REMOTE': '1', 15:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:50 INFO - 'NO_EM_RESTART': '1', 15:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:50 INFO - 'PWD': '/builds/slave/test', 15:17:50 INFO - 'SHELL': '/bin/bash', 15:17:50 INFO - 'SHLVL': '1', 15:17:50 INFO - 'TERM': 'linux', 15:17:50 INFO - 'TMOUT': '86400', 15:17:50 INFO - 'USER': 'cltbld', 15:17:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:50 INFO - '_': '/tools/buildbot/bin/python'} 15:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:50 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:17:50 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:17:50 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:17:50 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:17:50 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:17:50 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:17:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:52 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:17:52 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:17:52 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:17:52 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:17:52 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:17:52 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:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:52 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:17:52 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:17:52 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:17:52 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:17:52 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:17:52 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:17:53 INFO - Downloading docopt-0.6.1.tar.gz 15:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:53 INFO - Running setup.py install for blobuploader 15:17:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:53 INFO - Running setup.py install for requests 15:17:53 INFO - Running setup.py install for docopt 15:17:53 INFO - Successfully installed blobuploader requests docopt 15:17:53 INFO - Cleaning up... 15:17:53 INFO - Return code: 0 15:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:17:53 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:17:53 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:17:53 INFO - Using env: {'DISPLAY': ':0', 15:17:53 INFO - 'HOME': '/home/cltbld', 15:17:53 INFO - 'LANG': 'en_US.UTF-8', 15:17:53 INFO - 'LANGUAGE': 'en_US:en', 15:17:53 INFO - 'LOGNAME': 'cltbld', 15:17:53 INFO - 'MAIL': '/var/mail/cltbld', 15:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:53 INFO - 'MOZ_NO_REMOTE': '1', 15:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:53 INFO - 'NO_EM_RESTART': '1', 15:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:53 INFO - 'PWD': '/builds/slave/test', 15:17:53 INFO - 'SHELL': '/bin/bash', 15:17:53 INFO - 'SHLVL': '1', 15:17:53 INFO - 'TERM': 'linux', 15:17:53 INFO - 'TMOUT': '86400', 15:17:53 INFO - 'USER': 'cltbld', 15:17:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:53 INFO - '_': '/tools/buildbot/bin/python'} 15:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:54 INFO - Running setup.py (path:/tmp/pip-oA0bbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:54 INFO - Running setup.py (path:/tmp/pip-E6E0XE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:54 INFO - Running setup.py (path:/tmp/pip-Vilp2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:54 INFO - Running setup.py (path:/tmp/pip-rpET5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:54 INFO - Running setup.py (path:/tmp/pip-MrIPbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 INFO - Running setup.py (path:/tmp/pip-zpJCON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 INFO - Running setup.py (path:/tmp/pip-gfpSps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 INFO - Running setup.py (path:/tmp/pip-_2sWaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:54 INFO - Running setup.py (path:/tmp/pip-1qQXEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:54 INFO - Running setup.py (path:/tmp/pip-ajRaRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 INFO - Running setup.py (path:/tmp/pip-zSx1Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 INFO - Running setup.py (path:/tmp/pip-dsJV5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 INFO - Running setup.py (path:/tmp/pip-EWDZ95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:54 INFO - Running setup.py (path:/tmp/pip-FAKfNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:55 INFO - Running setup.py (path:/tmp/pip-SgOlgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:55 INFO - Running setup.py (path:/tmp/pip-x62Rrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:55 INFO - Running setup.py (path:/tmp/pip-0Tyjet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:55 INFO - Running setup.py install for manifestparser 15:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozcrash 15:17:55 INFO - Running setup.py install for mozdebug 15:17:55 INFO - Running setup.py install for mozdevice 15:17:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozfile 15:17:55 INFO - Running setup.py install for mozhttpd 15:17:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozinfo 15:17:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:55 INFO - Running setup.py install for mozInstall 15:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozleak 15:17:56 INFO - Running setup.py install for mozlog 15:17:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for moznetwork 15:17:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozprocess 15:17:56 INFO - Running setup.py install for mozprofile 15:17:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozrunner 15:17:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:56 INFO - Running setup.py install for mozscreenshot 15:17:56 INFO - Running setup.py install for moztest 15:17:56 INFO - Running setup.py install for mozversion 15:17:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:57 INFO - Cleaning up... 15:17:57 INFO - Return code: 0 15:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:57 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:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 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:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:17:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 15:17:57 INFO - 'HOME': '/home/cltbld', 15:17:57 INFO - 'LANG': 'en_US.UTF-8', 15:17:57 INFO - 'LANGUAGE': 'en_US:en', 15:17:57 INFO - 'LOGNAME': 'cltbld', 15:17:57 INFO - 'MAIL': '/var/mail/cltbld', 15:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:57 INFO - 'MOZ_NO_REMOTE': '1', 15:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:57 INFO - 'NO_EM_RESTART': '1', 15:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:57 INFO - 'PWD': '/builds/slave/test', 15:17:57 INFO - 'SHELL': '/bin/bash', 15:17:57 INFO - 'SHLVL': '1', 15:17:57 INFO - 'TERM': 'linux', 15:17:57 INFO - 'TMOUT': '86400', 15:17:57 INFO - 'USER': 'cltbld', 15:17:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:57 INFO - '_': '/tools/buildbot/bin/python'} 15:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:57 INFO - Running setup.py (path:/tmp/pip-dNlJ8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:57 INFO - Running setup.py (path:/tmp/pip-JyjPo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:57 INFO - Running setup.py (path:/tmp/pip-nZo7hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:57 INFO - Running setup.py (path:/tmp/pip-ONuMKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:57 INFO - Running setup.py (path:/tmp/pip-LyTqx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:57 INFO - Running setup.py (path:/tmp/pip-wqj_PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:57 INFO - Running setup.py (path:/tmp/pip-he3boJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:57 INFO - Running setup.py (path:/tmp/pip-LAQ7ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:57 INFO - Running setup.py (path:/tmp/pip-PzSxwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:57 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:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:57 INFO - Running setup.py (path:/tmp/pip-O3H0RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:58 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:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:58 INFO - Running setup.py (path:/tmp/pip-1HnGDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:58 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:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:58 INFO - Running setup.py (path:/tmp/pip-289GHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:58 INFO - Running setup.py (path:/tmp/pip-f0QRXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:58 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:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:58 INFO - Running setup.py (path:/tmp/pip-r3rntL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:58 INFO - Running setup.py (path:/tmp/pip-NUQsjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:58 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:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:58 INFO - Running setup.py (path:/tmp/pip-w5F3qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:58 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:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:58 INFO - Running setup.py (path:/tmp/pip-J1d9pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:17:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:18:00 INFO - Downloading blessings-1.6.tar.gz 15:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:00 INFO - Installing collected packages: blessings 15:18:00 INFO - Running setup.py install for blessings 15:18:00 INFO - Successfully installed blessings 15:18:00 INFO - Cleaning up... 15:18:00 INFO - Return code: 0 15:18:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:18:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:00 INFO - Reading from file tmpfile_stdout 15:18:00 INFO - Current package versions: 15:18:00 INFO - argparse == 1.2.1 15:18:00 INFO - blessings == 1.6 15:18:00 INFO - blobuploader == 1.2.4 15:18:00 INFO - docopt == 0.6.1 15:18:00 INFO - functools32 == 3.2.3-2 15:18:00 INFO - jsonschema == 2.5.1 15:18:00 INFO - manifestparser == 1.1 15:18:00 INFO - mozInstall == 1.12 15:18:00 INFO - mozcrash == 0.17 15:18:00 INFO - mozdebug == 0.1 15:18:00 INFO - mozdevice == 0.48 15:18:00 INFO - mozfile == 1.2 15:18:00 INFO - mozhttpd == 0.7 15:18:00 INFO - mozinfo == 0.9 15:18:00 INFO - mozleak == 0.1 15:18:00 INFO - mozlog == 3.2 15:18:00 INFO - moznetwork == 0.27 15:18:00 INFO - mozprocess == 0.22 15:18:00 INFO - mozprofile == 0.28 15:18:00 INFO - mozrunner == 6.11 15:18:00 INFO - mozscreenshot == 0.1 15:18:00 INFO - mozsystemmonitor == 0.3 15:18:00 INFO - moztest == 0.7 15:18:00 INFO - mozversion == 1.4 15:18:00 INFO - psutil == 3.1.1 15:18:00 INFO - requests == 1.2.3 15:18:00 INFO - wsgiref == 0.1.2 15:18:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:00 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 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:18:00 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:18:00 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:18:00 INFO - Using env: {'DISPLAY': ':0', 15:18:00 INFO - 'HOME': '/home/cltbld', 15:18:00 INFO - 'LANG': 'en_US.UTF-8', 15:18:00 INFO - 'LANGUAGE': 'en_US:en', 15:18:00 INFO - 'LOGNAME': 'cltbld', 15:18:00 INFO - 'MAIL': '/var/mail/cltbld', 15:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:00 INFO - 'MOZ_NO_REMOTE': '1', 15:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:00 INFO - 'NO_EM_RESTART': '1', 15:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:00 INFO - 'PWD': '/builds/slave/test', 15:18:00 INFO - 'SHELL': '/bin/bash', 15:18:00 INFO - 'SHLVL': '1', 15:18:00 INFO - 'TERM': 'linux', 15:18:00 INFO - 'TMOUT': '86400', 15:18:00 INFO - 'USER': 'cltbld', 15:18:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:00 INFO - '_': '/tools/buildbot/bin/python'} 15:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 INFO - Cleaning up... 15:18:01 INFO - Return code: 0 15:18:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:18: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:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:18:01 INFO - Using env: {'DISPLAY': ':0', 15:18:01 INFO - 'HOME': '/home/cltbld', 15:18:01 INFO - 'LANG': 'en_US.UTF-8', 15:18:01 INFO - 'LANGUAGE': 'en_US:en', 15:18:01 INFO - 'LOGNAME': 'cltbld', 15:18:01 INFO - 'MAIL': '/var/mail/cltbld', 15:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:01 INFO - 'MOZ_NO_REMOTE': '1', 15:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:01 INFO - 'NO_EM_RESTART': '1', 15:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:01 INFO - 'PWD': '/builds/slave/test', 15:18:01 INFO - 'SHELL': '/bin/bash', 15:18:01 INFO - 'SHLVL': '1', 15:18:01 INFO - 'TERM': 'linux', 15:18:01 INFO - 'TMOUT': '86400', 15:18:01 INFO - 'USER': 'cltbld', 15:18:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:01 INFO - '_': '/tools/buildbot/bin/python'} 15:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:18:01 INFO - Cleaning up... 15:18:01 INFO - Return code: 0 15:18:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:18: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:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ff5c44f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', '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:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:18:01 INFO - Using env: {'DISPLAY': ':0', 15:18:01 INFO - 'HOME': '/home/cltbld', 15:18:01 INFO - 'LANG': 'en_US.UTF-8', 15:18:01 INFO - 'LANGUAGE': 'en_US:en', 15:18:01 INFO - 'LOGNAME': 'cltbld', 15:18:01 INFO - 'MAIL': '/var/mail/cltbld', 15:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:01 INFO - 'MOZ_NO_REMOTE': '1', 15:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:01 INFO - 'NO_EM_RESTART': '1', 15:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:01 INFO - 'PWD': '/builds/slave/test', 15:18:01 INFO - 'SHELL': '/bin/bash', 15:18:01 INFO - 'SHLVL': '1', 15:18:01 INFO - 'TERM': 'linux', 15:18:01 INFO - 'TMOUT': '86400', 15:18:01 INFO - 'USER': 'cltbld', 15:18:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:01 INFO - '_': '/tools/buildbot/bin/python'} 15:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:01 INFO - Downloading/unpacking flake8 15:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:18:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:18:03 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:18:03 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:18:03 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:18:03 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:18:03 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:18:03 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:18:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:18:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:18:03 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:18:03 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:18:03 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:18:03 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:18:03 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:18:03 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:18:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:04 INFO - no previously-included directories found matching 'docs/_build' 15:18:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:18:04 INFO - Running setup.py install for pep8 15:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:04 INFO - no previously-included directories found matching 'docs/_build' 15:18:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:18:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:18:04 INFO - Cleaning up... 15:18:04 INFO - Return code: 0 15:18:04 INFO - Running post-action listener: _resource_record_post_action 15:18:04 INFO - Running post-action listener: _start_resource_monitoring 15:18:04 INFO - Starting resource monitoring. 15:18:04 INFO - ##### 15:18:04 INFO - ##### Finished create-virtualenv step (success) 15:18:04 INFO - ##### 15:18:04 INFO - ##### 15:18:04 INFO - ##### Running install step. 15:18:04 INFO - ##### 15:18:04 INFO - Running pre-action listener: _resource_record_pre_action 15:18:04 INFO - Running main action method: install 15:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:04 INFO - Reading from file tmpfile_stdout 15:18:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:04 INFO - Reading from file tmpfile_stdout 15:18:04 INFO - Output received: 15:18:04 INFO - Usage: mozinstall [options] installer 15:18:04 INFO - Options: 15:18:04 INFO - -h, --help show this help message and exit 15:18:04 INFO - -d DEST, --destination=DEST 15:18:04 INFO - Directory to install application into. [default: 15:18:04 INFO - "/builds/slave/test"] 15:18:04 INFO - --app=APP Application being installed. [default: firefox] 15:18:04 INFO - mkdir: /builds/slave/test/build/application 15:18:04 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:18:04 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:18:20 INFO - Reading from file tmpfile_stdout 15:18:20 INFO - Output received: 15:18:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:18:20 INFO - Running post-action listener: _resource_record_post_action 15:18:20 INFO - ##### 15:18:20 INFO - ##### Finished install step (success) 15:18:20 INFO - ##### 15:18:20 INFO - ##### 15:18:20 INFO - ##### Running run-tests step. 15:18:20 INFO - ##### 15:18:20 INFO - Running pre-action listener: _resource_record_pre_action 15:18:20 INFO - Running main action method: run_tests 15:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:20 INFO - Python 2.7.3 15:18:20 INFO - Return code: 0 15:18:20 INFO - grabbing minidump binary from tooltool 15:18: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:18:20 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 0xf7f1c0>, '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 0xf800c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:20 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:18:20 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:18:20 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:18:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:20 INFO - Return code: 0 15:18:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:18:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:18:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:18:21 INFO - Return code: 0 15:18:21 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/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:18:21 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/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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:18:21 INFO - Using env: {'DISPLAY': ':0', 15:18:21 INFO - 'HOME': '/home/cltbld', 15:18:21 INFO - 'LANG': 'en_US.UTF-8', 15:18:21 INFO - 'LANGUAGE': 'en_US:en', 15:18:21 INFO - 'LOGNAME': 'cltbld', 15:18:21 INFO - 'MAIL': '/var/mail/cltbld', 15:18:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:21 INFO - 'MOZ_NO_REMOTE': '1', 15:18:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:21 INFO - 'NO_EM_RESTART': '1', 15:18:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:21 INFO - 'PWD': '/builds/slave/test', 15:18:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:21 INFO - 'SHELL': '/bin/bash', 15:18:21 INFO - 'SHLVL': '1', 15:18:21 INFO - 'TERM': 'linux', 15:18:21 INFO - 'TMOUT': '86400', 15:18:21 INFO - 'USER': 'cltbld', 15:18:21 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005', 15:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:21 INFO - '_': '/tools/buildbot/bin/python'} 15:18:21 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/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:18:21 INFO - mozversion application_buildid: 20160630122127 15:18:21 INFO - mozversion application_changeset: cea38bcafb6ad58462496b582cec8eb361a727df 15:18:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:18:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:21 INFO - mozversion application_name: Firefox 15:18:21 INFO - mozversion application_remotingname: firefox-dev 15:18:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:18:21 INFO - mozversion application_vendor: Mozilla 15:18:21 INFO - mozversion application_version: 49.0a2 15:18:21 INFO - mozversion platform_buildid: 20160630122127 15:18:21 INFO - mozversion platform_changeset: cea38bcafb6ad58462496b582cec8eb361a727df 15:18:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:18:21 INFO - mozversion platform_version: 49.0a2 15:18:21 INFO - using testdate: 1467325101 15:18:21 INFO - actual date: 1467325101 15:18:21 INFO - starting webserver on 'localhost:57903' 15:18:21 INFO - SUITE-START | Running 2 tests 15:18:21 INFO - TEST-START | dromaeo_css 15:18:21 INFO - operating with platform_type : linux_ 15:18:21 INFO - Initialising browser for dromaeo_css test... 15:18:21 INFO - TEST-INFO | started process 11511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwtpMX/profile http://localhost:57903/getInfo.html) 15:18:26 INFO - PROCESS | 11511 | __metrics Screen width/height:1600/1200 15:18:26 INFO - PROCESS | 11511 | colorDepth:24 15:18:26 INFO - PROCESS | 11511 | Browser inner width/height: 1024/697 15:18:26 INFO - PROCESS | 11511 | __metrics 15:18:27 ERROR - PROCESS | 11511 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:18:28 INFO - TEST-INFO | 11511: exit 0 15:18:28 INFO - Browser initialized. 15:18:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:28 INFO - TEST-INFO | started process 11645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwtpMX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:40 INFO - PROCESS | 11645 | RSS: Main: 156086272 15:18:40 INFO - PROCESS | 11645 | 15:19:29 INFO - PROCESS | 11645 | 1467325169743 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:21:38 INFO - PROCESS | 11645 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57903/tests/dromaeo/cssquery-ext.html) 15:21:39 INFO - PROCESS | 11645 | RSS: Main: 159268864 15:21:39 INFO - PROCESS | 11645 | 15:24:41 INFO - PROCESS | 11645 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-ext.html (next: http://localhost:57903/tests/dromaeo/cssquery-jquery.html) 15:24:41 INFO - PROCESS | 11645 | RSS: Main: 157716480 15:24:41 INFO - PROCESS | 11645 | 15:27:43 INFO - PROCESS | 11645 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57903/tests/dromaeo/cssquery-mootools.html) 15:27:44 INFO - PROCESS | 11645 | RSS: Main: 157278208 15:27:44 INFO - PROCESS | 11645 | 15:30:45 INFO - PROCESS | 11645 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57903/tests/dromaeo/cssquery-prototype.html) 15:30:46 INFO - PROCESS | 11645 | RSS: Main: 156725248 15:30:46 INFO - PROCESS | 11645 | 15:33:49 INFO - PROCESS | 11645 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57903/tests/dromaeo/cssquery-yui.html) 15:33:49 INFO - PROCESS | 11645 | RSS: Main: 159031296 15:33:49 INFO - PROCESS | 11645 | 15:36:51 INFO - PROCESS | 11645 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-yui.html (next: http://localhost:57903/tests/dromaeo/cssquery-dojo.html) 15:36:52 INFO - PROCESS | 11645 | RSS: Main: 158990336 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | __start_tp_report 15:36:52 INFO - PROCESS | 11645 | _x_x_mozilla_page_load 15:36:52 INFO - PROCESS | 11645 | _x_x_mozilla_page_load_details 15:36:52 INFO - PROCESS | 11645 | |i|pagename|runs| 15:36:52 INFO - PROCESS | 11645 | |0;dojo.html;3402.234497238121;3404.914877128073;3433.3648275069113;3441.741869359798;3443.07037099983;5677.403872593381;5685.573581981353;5692.459216374443;5726.997775389305;5778.682172480512;5696.373398926125;5772.509336706375;5773.682447465399;5779.306483222019;5788.565857560689;5181.455947125563;5218.373795144588;5265.236540701615;5284.524392804647;5326.387465441466;5172.534471897528;5187.974060129694;5301.549368303698;5310.15037593985;5311.097113490716;5189.040027594907;5218.321618189649;5223.294855194538;5251.422343542207;5290.920636190441;5232.398274198478;5315.096433606296;5329.227262046981;5332.413434522199;5333.653312534711;5045.798168073273;5168.9224661630105;5229.581633469314;5287.312649355597;5287.550558202557;5473.17902314652;5480.835574932758;5510.311211098613;5612;5623.550115990711;6092.3603021682975;6142.078688196806;6143.877122457526;6145.047517634774;6156.445919867188;6055.27336719592;6125.816225513242;6185.845353866144;6230.43926046658;6241.781537646206;5698.572607054446;5770.903528329604;5802.071668533014;5830.650160990312;5840.561957853178;6309.495240380758;6314.526410519229;6321.620702757849;6326.145970294044;6354.269259035178;5837.7956771513645;5977.402259773988;6004.669743164168;6053.667048312297;6059.394060593905;6128.625347140816;6155.938440615537;6165.445109940038;6165.907511387333;6174.6912654368;6097.298810636745;6103.969480152571;6162.322144564095;6169.043798211284;6195.938040619536;5918.437748413894;6114.449699527064;6119.2350956130485;6123.038605230386;6164.568480206342;4714.15145273854;4721.173794585934;4723.669343146015;4748.881277968009;4750.714957102585;4196.538380778112;4201.579842015774;4215.641670458045;4231.386448964883;4250.553691862372;5750.2524671793235;5952.136940143655;5977.880442391215;6012.518998480111;6083.543734219951;6123.4351415035735;6197.132401463708;6197.938020619736;6300.2754683212015;6302.180716506917;5844.327902291206;6063.181470501514;6067.484263837623;6070.3929607038945;6074.119252708332;5251.186066159751;5255.973720131375;5299.2316114164005;5311.176767601028;5332;6424.614523128534;6449.484041276781;6451.580647257913;6454.257760357619;6501.869962600722;6006.918754624209;6212.77275040153;6223.097650840512;6227.813165605039;6231.2522497300615;6220.098085777447;6300.086487459384;6315.336889626707;6347.96826015867;6355.745770169141;6031.69841507914;6035.5473339500595;6070.1501789750355;6072.8785424292155;6092.756289748538;6008.1588577598295;6143.262808463013;6194.287656919331;6195.287541932736;6211.875762484635;6003.759849606142;6043.153958445909;6079.3312735598165;6102.603330783485;6126.142340072304;6026.9698651508215;6044;6045.727942242522;6046.334903160561;6077.270727512727;5745.597808153556;5859.121131830259;5869.090291004901;5959.553033522417;5969.104634304889;5998.940010599838;6048.969755151196;6072.817815465543;6082.817515474543;6090.9390906090375;5903.26209223847;5933.110033495011;5935.436133567304;5937.584369094122;5951.196588460675 15:36:52 INFO - PROCESS | 11645 | |1;ext.html;588.9116632505127;626.9655168965706;631.5673763472025;650.9869802603945;654.1822721598003;44669.77665111674;45992;46664.53335466644;49752.253716194195;50026;48017.51982480183;48634.75682621591;48756.75621621896;48783;48794;9012.50431226284;9183.54082295886;9196.034416386283;9204.355695101345;9207.723768286929;8993.730188094334;9059.909400905972;9082.54587270637;9084.454932704026;9092.181703646671;9078.954605226965;9155.450672959643;9172.357934944557;9185.770355741093;9193.080691930787;9146.314026447977;9161.450312981242;9163.35856490046;9183.540822958892;9197.816043679122;8806.471611703319;8885.378023538355;8910.376273660846;8924.107589241088;8989.41568798026;44688.77655611734;44778.552214477764;44972.3254151188;45363.319550206776;45470.77264613689;3795.7912314822674;3800.7909564973916;3807.3908174691915;3846.38457846746;3884.2231553689376;33892.32215355679;34300.656993430246;34821;35103.29793404143;35782.28435431303;4829.396325459317;4855.198892182786;4874.2201247800185;4967.081089998362;5054.545090941796;368687.6262474762;371179;372820;373055;374737.99999999726;37817.62182378196;38956;65422;65963.67018164879;66036.33963660398;40236.79881600632;40388;40458.19083618311;40530.39204411877;40590.79704601458;13442.32788360578;13457.25985070811;13479.797803032963;13486.460541578423;13526.391312390966;13344.999125065659;13354.065215435021;13366.131201471873;13420.261885596386;13464.730705385837;9098.181163695166;9104.453732776055;9174.67888623895;9255.259579233645;9261.583228754722;3444.483327500845;3493.94759078614;3519.384107781128;3523.119220194951;3571.2143328467696;1075.3924032921375;1075.704181350135;1085.2511766880828;1111.4664960818852;1204.2413279633774;33907.66092339094;33923.66076339205;34189.658103418646;34265.82867085699;34515.82742086273;1122.1359553144196;1169.91225658076;1242.2298175131295;1256.4597223194114;1260.1053252190864;17238.224279907434;17529.01917422422;17535.64928701419;17571.297148113932;17701.203445844967;890346;1003497;1009791;1010533;1021142;58274.708626456595;58641.120383194284;59134;59187.40812591905;59421.70289148526;1466.4280930437137;1471.3084850120426;1491.4705279625578;1492.1718446262212;1498.3257534109475;33650.15874603154;33769.83115084409;33858.32283354369;33863.83068084742;34605.48091778676;56958;59970.100448492434;61936.38063619306;62168.37831621807;68407.65796170988;508037;510583;514157;515239;516541;48219.75890120527;48331.75834120807;48708.269375960095;48922.755386224264;49036.75481622569;53367.4663253378;53858.730706346214;54366.184507233214;55007.72496137494;55425.060122895506;43821.409123382335;44456.77771611121;44651;45545.54454455546;45620.54379456296;43843.05795118862;43912.560874390845;44674.776626117964;44952.550474494834;45714.085718286115;44133.33799992938;45298.54701452943;45595.54404455913;45689.08621827478;45744;38354.23291534098;38376;38998.610013899495;39124.217515650096;40139.799301004474;29485.410291793614;29662;29930.85034574813;30151.698483015767;30214 15:36:52 INFO - PROCESS | 11645 | |2;jquery.html;429.2702405909954;432.7511680783549;434.5220257716511;438.69510690070416;440.3421119485137;18442.354517591888;19650.606987860236;20187.899060504715;20571.691424628607;20789.792102078976;17546;17926.19332130054;18949.715754263696;18995.43013709591;19175.520611984706;5421.9457805421935;5619.690916999563;5670.68811215383;5671.432856714337;5679.801206957757;5551.444855514436;5629.324481062258;5679.346875109353;6007.579469437142;6022.939770602282;6046.697665116749;6061.969690151565;6069.969650151743;6070.726817293233;6087.543434242428;6021.789237376693;6023.337432882379;6109.847253818646;6123.112148738408;6138.386161383871;5253.921191182136;5954.642721436684;5974.820755377345;5978.8206353809455;5983.222181116427;23492.7650723494;23737.050517979435;23739.169129080572;23986.52026959451;24024.15915442951;2529.544681957247;2699.163259389576;2862.6278583784183;3060.709232622897;3066.9233269168226;10126.038026387556;10227.89772102277;10332.94833525835;10373.740656483573;12440;1774.476529423823;1826.3607737291975;1857.368494711791;1890.225007746831;1935.7483527141521;79841;83908;84783;85265;85468.57265713695;11516.539338426537;11547.76904461906;11661.18371713989;11710.824337634942;11947.880521194851;16226.837731622769;16278.918605406898;16289.429869954494;16407.507774766775;16528.586785330222;8396.622152003052;8472.74581762548;8516.06323304436;8678.652853885775;8718.782030449289;8149.388795840336;8153.388495862834;8211.260986511243;8272.420930534805;8287.254147126787;4967.205247160509;4997.075541024922;5015.573676237488;5040.31955685985;5164.56101231392;1689.222957439567;1840.3742727472722;1843.8709290349816;2049.928252511155;2093.0895060648363;969.6703120938914;1008.9192864570816;1064.122099268107;1079.6383211624193;1113.716002419378;18514.907425462785;19620.803791962182;19639.410817675493;19735.802641973685;19929.10319035647;1004.8191325561469;1042.598599539183;1079.0450451350612;1111.9332840029624;1125.6004118537965;10883.510242039127;11063.22557420989;11209.831852522218;11261.324320540794;11263.718407039889;489391;490257;501365;505560;505938;60589;83793.58103209444;91461.54269228611;93449;96903;981.2983716642635;1045.4459136657583;1066.5147357952112;1068.631322193842;1077.1275267033727;18257.45227643173;18270;18699.813001870352;18733.90633046826;18832.62334753325;38216.04459888525;42212;42732.14535709331;44696.55303446924;45360.31959520544;49908.25137622866;61254;61496;61638.69180654068;61936.38063619487;8521.53131577769;8834.779130521789;8970.147835955573;8974.775630609025;11842.407879606157;9285.396449231048;9424.293178011814;13018;13180.209187448783;13434.529791457642;8544.530050847263;8688.56720118368;8918.24194943437;8926.598303076247;9043.954780226057;8614.526201058752;8622.78443038929;8677.913220867964;8717.65129394817;8850.513221772864;9095.544712845913;9200.585973631069;9211.769705757142;9214.308926830381;9217.58520866576;12664.493420263087;12828.743425131259;12852.614421567368;12922.483100675867;12989.610311690287;12183.817242741543;12334.629961101182;12344.13591048618;12393.814092788796;12614.684632884251 15:36:52 INFO - PROCESS | 11645 | |3;mootools.html;1538.269322072016;1556.5252597957622;1773.4236373178712;1874.9062546872653;1878.9906050469745;8249.175082491747;9400.858987115198;9462.337636365457;10190.235732320078;10192.235582331326;9423.15191632753;9743.366681165719;9812.55843487043;9835.60657573698;9893.950530247339;2462.113639089926;2490.887910044052;2507.6238564215423;2516.069054449856;2524.823262371635;2448.865312407817;2511.4349271413967;2513.861737604431;2517.0309430869156;2520.420303330235;2456.6683497727845;2459.32368598635;2501.4121681404854;2506.6616006839026;2523.4826860493645;2492.2149522900227;2540.771330580247;2551.107112510625;2577.9226623201334;2579.239124458289;2419.697537807774;2460.5447992121335;2461.9015239390583;2465.2234546117916;2470.468849197431;9808.754781130458;9835.409875407428;9850.655227067018;9898.90101098987;9941;5698.145278208261;5722.484976352107;5748.971255143698;5785.045467497858;5845.2401187845735;3677.9771125880925;3805.2389522095414;3806.809659517013;3817.6945844332386;3908.5505166905887;1232.4577186038114;1266.6073517209602;1272.338384040303;1274.796032634774;1291.2704322058007;14290.785638215435;14304.284785760774;14309.141451512838;14331.71336573273;14341;5065.670731402447;5079.161938280216;5081.644284900021;5084.44071152173;5164.896702066013;11830.40847957616;11853.46659400329;11855;11870.762584748256;11873.228240164362;5796.62321949072;5806.65160090396;5809.622374545641;5819.301683797971;5823.970880145572;4405.251107311765;5133;5233.869153271199;5247.842564723064;5297.5232229099565;4210.410542524049;4278.058827058042;4317.568243175658;4335.1329734053315;4347.8260869564865;1334.5729366602593;1367.4803574641771;1370.4792178971927;1388.4585011845388;1395.379056319928;1010.0909181736496;1028.753099256188;1035.1977217656226;1036.9585216591402;1044.6865940217904;6340.841478963062;6632.071509988606;6638.634875081917;6658.43403310724;6715.4291885190305;972.8589354543693;1005.5625802775816;1022.4172221833633;1038.7299302181336;1055.6094245129352;4331.913361732748;4450.354698568754;4457.754823484739;4462;4480.238359478896;12261.26432414058;12645.241285522898;12651.114421990373;12673.619791406272;12695.68260793469;11774.175807693551;12301.938490307492;12329.075319350904;12638;12658.620241392773;9105.590248438835;9162.129597688208;9192.356535042616;9235.815283694288;9287.535623218948;6463.15978922737;6706.899396509154;6856.211535673262;6953.79138625842;6984.895226571707;11366.261193022427;11469.426528673366;11623;11713.238639488405;11765;11466;11615.941920290345;11752.471138798604;11880.168388212742;12032.977196938358;7700;8563.95718021431;8857;8932.732018039469;8950;9763;9805.705828825146;9814.607415703293;9874.160696340605;9904.702858914245;8503.8724419135;8676.696315628922;8721.65113395457;8755.25580325654;8789.868151977853;8163.632636531252;8191.549464779494;8536.402451828313;8614.267787238156;8634.654613815377;7749.186335434698;7775.494592851446;7865.882011769942;7867.763967080997;7873.645685944261;5698.686572238566;5802.274715660543;5914.526837852875;5946.226990491208;5999.5800293979;5367.302250707383;5406.540444062299;5804.709764511673;5874.765009399576;5879.323877754113 15:36:52 INFO - PROCESS | 11645 | |4;prototype.html;350.4760383227076;358.50168266110114;360.0351059161448;369.8982779735574;374.9118957045094;5513.531349835269;5677.545796336293;5784.5661575381855;5785.82642520725;5830.7667693292215;5635.6055076144585;5706;5710.5717071219615;5721.856953576153;5735.684537350444;4450.26570615848;4484.847273308814;4486.97756511217;4487.663425243103;4510.233260345733;4432.756198409086;4486.977565112186;4502.932456013163;4516.683832131752;4529.980754330282;4412.691111622188;4412.779361031951;4427.1367083418745;4430.556944305576;4463.598276155145;4294.184105020036;4457.955420445803;4463.464384273875;4483.282674772021;4483.327500874895;3886.1839013807135;3900.395438707005;3921.901952451183;3928.017995501125;3936.626020528045;5470.124780035176;5503.834884953458;5507.7246137692955;5513.42109078549;5514.338279406497;4859.781309841065;5058.822941197077;5065.1642478990925;5100.515451032146;5126.359205099363;5985.610935289193;6011.669358185298;6018.916595012896;6026.517878569748;6031.849203769897;4359.367891655724;4364.607185353333;4369.1480161368545;4377.474703035656;4377.846775362847;6113.296970848321;6258.280297765769;6281.7173227204885;6314.463270622003;6315.557910946236;4400.733622184577;4418.403515525363;4424.557544245614;4426.468823741172;4449.844255451108;4508.436445444319;4517.706349087299;4524.705894116872;4528.366028755977;4534.682572219913;5021.84934451967;5099.388073431212;5101.897962040813;5137.280780690707;5142.971405718871;5805.216295800097;6007.476859718929;6033.461467325892;6057.878842423127;6062.333143354227;1524.4969160177116;1537.6770878115497;1549.5506303172178;1554;1568.9764653529978;985.6944347252374;990.3364745620452;992.3599278465349;1004.2016596805557;1023.5138309303021;5276.129438642581;5283.6037297202865;5302.496262855023;5318.9202161967605;5409.43200963901;5558.888822223533;5595.888082238333;5628.690422026828;5640.323161220597;5642.6614403135945;5320.707361095099;5344.385395679469;5657.915131273035;6009.36901625323;6023;3277.737780977516;3306.470964645645;3333.633300336961;3340.88306909257;3356.3455126250146;6238.376162383816;6429.6463694496315;6486.383793539606;6495.902561461582;6543.993844708802;6304.65324407162;6309.14826498426;6392.456641185551;6406.935930640727;6418.19772528434;6363.936360636334;6510.414062734377;6562.5406221564035;6584.617230381674;6585.209774827052;6091.177691011657;6112.541559383153;6196.442320191204;6279.434850863444;6327.746890124344;6160.10678451631;6171.981623032149;6228.131560531913;6231;6248.562600617913;6306.972653126433;6523.347665233438;6532.902006469812;6535.451174042222;6548.377904099103;4399.802008909671;4417.580329868657;4436.26801577736;4451.799669014967;4468.3074123510905;5985.827511418781;6101.694915254131;6254.530910181846;6264.5301602379095;6281.214848143982;6034.69826508664;6045.491121184835;6059.545534085049;6064.878702425838;6076.574639775174;6013.218281623361;6025.758969641165;6037.245344331958;6049.274087109575;6085.1785009023215;5671.319441667027;6003.609765365237;6029.728662210299;6030.7889223876955;6052.515798736179;6108.953500577356;6141.539384546266;6149.907751383644;6153.907691384722;6175.814725558061;5703.914441283301;5949.281698938164;5983.551233657406;5986.742784015406;5987.221661184019 15:36:52 INFO - PROCESS | 11645 | |5;yui.html;793.7698067560405;814.6822739131736;847.0428415890043;863.2446609216935;909.4815954905698;15299.235038248085;16604.584885377855;16632.584185395357;17176.22706978186;17257.91371043143;15809.130497822614;16056.678866422693;16068.83931160688;16104.919475402636;16146.273417696202;819.19309480162;845.7293666026874;848.8896443462341;849.9405041647087;851.953142577158;848.3128665780737;851.9872201916976;854.4147259127486;854.9871751923727;858.5621333120091;903.8960519540271;908.418612088264;909.5406819556115;910.3718434280325;911.5351170902854;900.333753022765;904.9638014479413;906.071276941134;906.5648488725449;907.5144797533321;656.1044174701545;659.9208095028579;663.0948754949459;664.5447868210243;666.6566718140161;15578.688426231525;15669.608259793482;15701.450449234222;15748.527544173694;15759.921200393925;15268.38926442941;15284.082955022623;15312.923435382752;15462.690746185013;15765.842341576552;12691.301978391184;12717.809232861515;12723.809142862865;12727.109102362838;12739.61781146567;4059.6752259819145;4077.041895154636;4077.633013028812;4134.37984302354;4147.771872547009;67694.3230567693;75723;76782;79781;79794.20205797926;12360.381980900918;12755.808662870064;12768.425420856083;12848.100632955604;12911.483540658457;22604.09583616637;22685.2060177893;22711.545769084856;22740.772592273865;22765.772342276698;9493.90506094944;9580.425174489554;9621.90378096224;9678.661246856467;9729.173020293212;5242.68543887368;5307.52232299095;5347.41178470368;5405.5135037846785;5503.614746967673;3977.5624681285035;4100.897477563085;4106.507219133723;4107.8973025674;4112.753234805921;671.8589096289834;676.1683129750435;679.7688785812848;702.2170280137711;706.4348521183033;720.7765592666291;835.7242110103651;852.3436953545735;854.4446110028407;865.0959747064333;10907.454627268764;11159.72100697489;11246.437678116225;11272.436378181223;11326;744.7840126363402;774.156169774948;781.7029528779141;827.6275675945849;836.1137194573771;5262.973685131627;5281.656692314988;5365.651232669864;5449.6730196188355;5456.48163424474;116428.41785791017;116990.41504792421;117679.41160294315;119311.40344298223;123845.38077309736;64809;65029.34970650328;71911.28088719046;97440;101330;89645.55177224072;89648.5517572408;91084;92195.5390223058;92598;9783.804323913624;9918.950405247928;9959.253056020683;9971.551280192263;10061.39631622105;38453.80773096117;45883.54116458793;53057.469425306794;53124.73437632942;55328.17007744968;69620.6518967402;75990;76389;77174.61412692901;77670;13087.476500939856;13101.803472948104;13194.472221111431;13433.462661493431;13441.731165376834;14160.504382346568;14972.7005459888;15043;15047.623809404853;15398.07611543311;14575.489857854924;14782.556523304318;15031.323590438238;15223.695526089195;15830.841691583397;15227.619309517351;15978.840211597735;15990.120543369761;16140.435084771976;16304.918475407547;14973.925130374279;15052.54842354731;15802.60493487672;16092.758608620647;16369.09969951664;12017.699557510783;12272.570460033856;12371.628851134481;12553.748925021631;12698.238105713686;11816.704582385166;12424.627261182179;12452.049868137035;12760.361981900682;12764.489420423079 15:36:52 INFO - PROCESS | 11645 | __end_tp_report 15:36:52 INFO - PROCESS | 11645 | __start_cc_report 15:36:52 INFO - PROCESS | 11645 | _x_x_mozilla_cycle_collect,341 15:36:52 INFO - PROCESS | 11645 | __end_cc_report 15:36:52 INFO - PROCESS | 11645 | __startTimestamp1467326212241__endTimestamp 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | ------- Summary: start ------- 15:36:52 INFO - PROCESS | 11645 | Number of tests: 6 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | [#0] dojo.html Cycles:165 Average:5729.84 Median:5998.94 stddev:640.59 (10.7%) stddev-sans-first:615.98 15:36:52 INFO - PROCESS | 11645 | Values: 3402.2 3404.9 3433.4 3441.7 3443.1 5677.4 5685.6 5692.5 5727.0 5778.7 5696.4 5772.5 5773.7 5779.3 5788.6 5181.5 5218.4 5265.2 5284.5 5326.4 5172.5 5188.0 5301.5 5310.2 5311.1 5189.0 5218.3 5223.3 5251.4 5290.9 5232.4 5315.1 5329.2 5332.4 5333.7 5045.8 5168.9 5229.6 5287.3 5287.6 5473.2 5480.8 5510.3 5612.0 5623.6 6092.4 6142.1 6143.9 6145.0 6156.4 6055.3 6125.8 6185.8 6230.4 6241.8 5698.6 5770.9 5802.1 5830.7 5840.6 6309.5 6314.5 6321.6 6326.1 6354.3 5837.8 5977.4 6004.7 6053.7 6059.4 6128.6 6155.9 6165.4 6165.9 6174.7 6097.3 6104.0 6162.3 6169.0 6195.9 5918.4 6114.4 6119.2 6123.0 6164.6 4714.2 4721.2 4723.7 4748.9 4750.7 4196.5 4201.6 4215.6 4231.4 4250.6 5750.3 5952.1 5977.9 6012.5 6083.5 6123.4 6197.1 6197.9 6300.3 6302.2 5844.3 6063.2 6067.5 6070.4 6074.1 5251.2 5256.0 5299.2 5311.2 5332.0 6424.6 6449.5 6451.6 6454.3 6501.9 6006.9 6212.8 6223.1 6227.8 6231.3 6220.1 6300.1 6315.3 6348.0 6355.7 6031.7 6035.5 6070.2 6072.9 6092.8 6008.2 6143.3 6194.3 6195.3 6211.9 6003.8 6043.2 6079.3 6102.6 6126.1 6027.0 6044.0 6045.7 6046.3 6077.3 5745.6 5859.1 5869.1 5959.6 5969.1 5998.9 6049.0 6072.8 6082.8 6090.9 5903.3 5933.1 5935.4 5937.6 5951.2 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | [#1] ext.html Cycles:180 Average:76513.99 Median:44865.55 stddev:183447.91 (408.9%) stddev-sans-first:183873.95 15:36:52 INFO - PROCESS | 11645 | Values: 588.9 627.0 631.6 651.0 654.2 44669.8 45992.0 46664.5 49752.3 50026.0 48017.5 48634.8 48756.8 48783.0 48794.0 9012.5 9183.5 9196.0 9204.4 9207.7 8993.7 9059.9 9082.5 9084.5 9092.2 9079.0 9155.5 9172.4 9185.8 9193.1 9146.3 9161.5 9163.4 9183.5 9197.8 8806.5 8885.4 8910.4 8924.1 8989.4 44688.8 44778.6 44972.3 45363.3 45470.8 3795.8 3800.8 3807.4 3846.4 3884.2 33892.3 34300.7 34821.0 35103.3 35782.3 4829.4 4855.2 4874.2 4967.1 5054.5 368687.6 371179.0 372820.0 373055.0 374738.0 37817.6 38956.0 65422.0 65963.7 66036.3 40236.8 40388.0 40458.2 40530.4 40590.8 13442.3 13457.3 13479.8 13486.5 13526.4 13345.0 13354.1 13366.1 13420.3 13464.7 9098.2 9104.5 9174.7 9255.3 9261.6 3444.5 3493.9 3519.4 3523.1 3571.2 1075.4 1075.7 1085.3 1111.5 1204.2 33907.7 33923.7 34189.7 34265.8 34515.8 1122.1 1169.9 1242.2 1256.5 1260.1 17238.2 17529.0 17535.6 17571.3 17701.2 890346.0 1003497.0 1009791.0 1010533.0 1021142.0 58274.7 58641.1 59134.0 59187.4 59421.7 1466.4 1471.3 1491.5 1492.2 1498.3 33650.2 33769.8 33858.3 33863.8 34605.5 56958.0 59970.1 61936.4 62168.4 68407.7 508037.0 510583.0 514157.0 515239.0 516541.0 48219.8 48331.8 48708.3 48922.8 49036.8 53367.5 53858.7 54366.2 55007.7 55425.1 43821.4 44456.8 44651.0 45545.5 45620.5 43843.1 43912.6 44674.8 44952.6 45714.1 44133.3 45298.5 45595.5 45689.1 45744.0 38354.2 38376.0 38998.6 39124.2 40139.8 29485.4 29662.0 29930.9 30151.7 30214.0 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | [#2] jquery.html Cycles:180 Average:29279.21 Median:431.01 stddev:82106.18 (19049.7%) stddev-sans-first:82307.93 15:36:52 INFO - PROCESS | 11645 | Values: 429.3 432.8 434.5 438.7 440.3 18442.4 19650.6 20187.9 20571.7 20789.8 17546.0 17926.2 18949.7 18995.4 19175.5 5421.9 5619.7 5670.7 5671.4 5679.8 5551.4 5629.3 5679.3 6007.6 6022.9 6046.7 6062.0 6070.0 6070.7 6087.5 6021.8 6023.3 6109.8 6123.1 6138.4 5253.9 5954.6 5974.8 5978.8 5983.2 23492.8 23737.1 23739.2 23986.5 24024.2 2529.5 2699.2 2862.6 3060.7 3066.9 10126.0 10227.9 10332.9 10373.7 12440.0 1774.5 1826.4 1857.4 1890.2 1935.7 79841.0 83908.0 84783.0 85265.0 85468.6 11516.5 11547.8 11661.2 11710.8 11947.9 16226.8 16278.9 16289.4 16407.5 16528.6 8396.6 8472.7 8516.1 8678.7 8718.8 8149.4 8153.4 8211.3 8272.4 8287.3 4967.2 4997.1 5015.6 5040.3 5164.6 1689.2 1840.4 1843.9 2049.9 2093.1 969.7 1008.9 1064.1 1079.6 1113.7 18514.9 19620.8 19639.4 19735.8 19929.1 1004.8 1042.6 1079.0 1111.9 1125.6 10883.5 11063.2 11209.8 11261.3 11263.7 489391.0 490257.0 501365.0 505560.0 505938.0 60589.0 83793.6 91461.5 93449.0 96903.0 981.3 1045.4 1066.5 1068.6 1077.1 18257.5 18270.0 18699.8 18733.9 18832.6 38216.0 42212.0 42732.1 44696.6 45360.3 49908.3 61254.0 61496.0 61638.7 61936.4 8521.5 8834.8 8970.1 8974.8 11842.4 9285.4 9424.3 13018.0 13180.2 13434.5 8544.5 8688.6 8918.2 8926.6 9044.0 8614.5 8622.8 8677.9 8717.7 8850.5 9095.5 9200.6 9211.8 9214.3 9217.6 12664.5 12828.7 12852.6 12922.5 12989.6 12183.8 12334.6 12344.1 12393.8 12614.7 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | [#3] mootools.html Cycles:180 Average:6506.16 Median:4341.48 stddev:3806.18 (87.7%) stddev-sans-first:3798.55 15:36:52 INFO - PROCESS | 11645 | Values: 1538.3 1556.5 1773.4 1874.9 1879.0 8249.2 9400.9 9462.3 10190.2 10192.2 9423.2 9743.4 9812.6 9835.6 9894.0 2462.1 2490.9 2507.6 2516.1 2524.8 2448.9 2511.4 2513.9 2517.0 2520.4 2456.7 2459.3 2501.4 2506.7 2523.5 2492.2 2540.8 2551.1 2577.9 2579.2 2419.7 2460.5 2461.9 2465.2 2470.5 9808.8 9835.4 9850.7 9898.9 9941.0 5698.1 5722.5 5749.0 5785.0 5845.2 3678.0 3805.2 3806.8 3817.7 3908.6 1232.5 1266.6 1272.3 1274.8 1291.3 14290.8 14304.3 14309.1 14331.7 14341.0 5065.7 5079.2 5081.6 5084.4 5164.9 11830.4 11853.5 11855.0 11870.8 11873.2 5796.6 5806.7 5809.6 5819.3 5824.0 4405.3 5133.0 5233.9 5247.8 5297.5 4210.4 4278.1 4317.6 4335.1 4347.8 1334.6 1367.5 1370.5 1388.5 1395.4 1010.1 1028.8 1035.2 1037.0 1044.7 6340.8 6632.1 6638.6 6658.4 6715.4 972.9 1005.6 1022.4 1038.7 1055.6 4331.9 4450.4 4457.8 4462.0 4480.2 12261.3 12645.2 12651.1 12673.6 12695.7 11774.2 12301.9 12329.1 12638.0 12658.6 9105.6 9162.1 9192.4 9235.8 9287.5 6463.2 6706.9 6856.2 6953.8 6984.9 11366.3 11469.4 11623.0 11713.2 11765.0 11466.0 11615.9 11752.5 11880.2 12033.0 7700.0 8564.0 8857.0 8932.7 8950.0 9763.0 9805.7 9814.6 9874.2 9904.7 8503.9 8676.7 8721.7 8755.3 8789.9 8163.6 8191.5 8536.4 8614.3 8634.7 7749.2 7775.5 7865.9 7867.8 7873.6 5698.7 5802.3 5914.5 5946.2 5999.6 5367.3 5406.5 5804.7 5874.8 5879.3 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | [#4] prototype.html Cycles:180 Average:5061.14 Median:5650.29 stddev:1493.02 (26.4%) stddev-sans-first:1454.74 15:36:52 INFO - PROCESS | 11645 | Values: 350.5 358.5 360.0 369.9 374.9 5513.5 5677.5 5784.6 5785.8 5830.8 5635.6 5706.0 5710.6 5721.9 5735.7 4450.3 4484.8 4487.0 4487.7 4510.2 4432.8 4487.0 4502.9 4516.7 4530.0 4412.7 4412.8 4427.1 4430.6 4463.6 4294.2 4458.0 4463.5 4483.3 4483.3 3886.2 3900.4 3921.9 3928.0 3936.6 5470.1 5503.8 5507.7 5513.4 5514.3 4859.8 5058.8 5065.2 5100.5 5126.4 5985.6 6011.7 6018.9 6026.5 6031.8 4359.4 4364.6 4369.1 4377.5 4377.8 6113.3 6258.3 6281.7 6314.5 6315.6 4400.7 4418.4 4424.6 4426.5 4449.8 4508.4 4517.7 4524.7 4528.4 4534.7 5021.8 5099.4 5101.9 5137.3 5143.0 5805.2 6007.5 6033.5 6057.9 6062.3 1524.5 1537.7 1549.6 1554.0 1569.0 985.7 990.3 992.4 1004.2 1023.5 5276.1 5283.6 5302.5 5318.9 5409.4 5558.9 5595.9 5628.7 5640.3 5642.7 5320.7 5344.4 5657.9 6009.4 6023.0 3277.7 3306.5 3333.6 3340.9 3356.3 6238.4 6429.6 6486.4 6495.9 6544.0 6304.7 6309.1 6392.5 6406.9 6418.2 6363.9 6510.4 6562.5 6584.6 6585.2 6091.2 6112.5 6196.4 6279.4 6327.7 6160.1 6172.0 6228.1 6231.0 6248.6 6307.0 6523.3 6532.9 6535.5 6548.4 4399.8 4417.6 4436.3 4451.8 4468.3 5985.8 6101.7 6254.5 6264.5 6281.2 6034.7 6045.5 6059.5 6064.9 6076.6 6013.2 6025.8 6037.2 6049.3 6085.2 5671.3 6003.6 6029.7 6030.8 6052.5 6109.0 6141.5 6149.9 6153.9 6175.8 5703.9 5949.3 5983.6 5986.7 5987.2 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - PROCESS | 11645 | [#5] yui.html Cycles:180 Average:21084.00 Median:4123.57 stddev:29297.63 (710.5%) stddev-sans-first:29340.20 15:36:52 INFO - PROCESS | 11645 | Values: 793.8 814.7 847.0 863.2 909.5 15299.2 16604.6 16632.6 17176.2 17257.9 15809.1 16056.7 16068.8 16104.9 16146.3 819.2 845.7 848.9 849.9 852.0 848.3 852.0 854.4 855.0 858.6 903.9 908.4 909.5 910.4 911.5 900.3 905.0 906.1 906.6 907.5 656.1 659.9 663.1 664.5 666.7 15578.7 15669.6 15701.5 15748.5 15759.9 15268.4 15284.1 15312.9 15462.7 15765.8 12691.3 12717.8 12723.8 12727.1 12739.6 4059.7 4077.0 4077.6 4134.4 4147.8 67694.3 75723.0 76782.0 79781.0 79794.2 12360.4 12755.8 12768.4 12848.1 12911.5 22604.1 22685.2 22711.5 22740.8 22765.8 9493.9 9580.4 9621.9 9678.7 9729.2 5242.7 5307.5 5347.4 5405.5 5503.6 3977.6 4100.9 4106.5 4107.9 4112.8 671.9 676.2 679.8 702.2 706.4 720.8 835.7 852.3 854.4 865.1 10907.5 11159.7 11246.4 11272.4 11326.0 744.8 774.2 781.7 827.6 836.1 5263.0 5281.7 5365.7 5449.7 5456.5 116428.4 116990.4 117679.4 119311.4 123845.4 64809.0 65029.3 71911.3 97440.0 101330.0 89645.6 89648.6 91084.0 92195.5 92598.0 9783.8 9919.0 9959.3 9971.6 10061.4 38453.8 45883.5 53057.5 53124.7 55328.2 69620.7 75990.0 76389.0 77174.6 77670.0 13087.5 13101.8 13194.5 13433.5 13441.7 14160.5 14972.7 15043.0 15047.6 15398.1 14575.5 14782.6 15031.3 15223.7 15830.8 15227.6 15978.8 15990.1 16140.4 16304.9 14973.9 15052.5 15802.6 16092.8 16369.1 12017.7 12272.6 12371.6 12553.7 12698.2 11816.7 12424.6 12452.0 12760.4 12764.5 15:36:52 INFO - PROCESS | 11645 | -------- Summary: end -------- 15:36:52 INFO - PROCESS | 11645 | 15:36:52 INFO - TEST-INFO | 11645: exit 0 15:36:52 INFO - TEST-OK | dromaeo_css | took 1110899ms 15:36:52 INFO - TEST-START | kraken 15:36:52 INFO - operating with platform_type : linux_ 15:36:52 INFO - Initialising browser for kraken test... 15:36:52 INFO - TEST-INFO | started process 11882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxnQqa/profile http://localhost:57903/getInfo.html) 15:36:57 INFO - PROCESS | 11882 | __metrics Screen width/height:1600/1200 15:36:57 INFO - PROCESS | 11882 | colorDepth:24 15:36:57 INFO - PROCESS | 11882 | Browser inner width/height: 1024/697 15:36:57 INFO - PROCESS | 11882 | __metrics 15:36:58 ERROR - PROCESS | 11882 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:36:59 INFO - TEST-INFO | 11882: exit 0 15:36:59 INFO - Browser initialized. 15:36:59 INFO - Running cycle 1/1 for kraken test... 15:36:59 INFO - TEST-INFO | started process 12008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptxnQqa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:11 INFO - PROCESS | 12008 | RSS: Main: 155856896 15:37:11 INFO - PROCESS | 12008 | 15:37:13 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:14 INFO - PROCESS | 12008 | RSS: Main: 161157120 15:37:14 INFO - PROCESS | 12008 | 15:37:17 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-dft) 15:37:17 INFO - PROCESS | 12008 | RSS: Main: 160542720 15:37:17 INFO - PROCESS | 12008 | 15:37:20 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-fft) 15:37:21 INFO - PROCESS | 12008 | RSS: Main: 160980992 15:37:21 INFO - PROCESS | 12008 | 15:37:23 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-oscillator) 15:37:24 INFO - PROCESS | 12008 | RSS: Main: 160964608 15:37:24 INFO - PROCESS | 12008 | 15:37:26 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:26 INFO - PROCESS | 12008 | RSS: Main: 160874496 15:37:26 INFO - PROCESS | 12008 | 15:37:29 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57903/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:30 INFO - PROCESS | 12008 | RSS: Main: 160997376 15:37:30 INFO - PROCESS | 12008 | 15:37:33 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57903/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:34 INFO - PROCESS | 12008 | RSS: Main: 161640448 15:37:34 INFO - PROCESS | 12008 | 15:37:37 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57903/tests/kraken/driver.html?testName=json-parse-financial) 15:37:37 INFO - PROCESS | 12008 | RSS: Main: 161181696 15:37:37 INFO - PROCESS | 12008 | 15:37:39 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:40 INFO - PROCESS | 12008 | RSS: Main: 161280000 15:37:40 INFO - PROCESS | 12008 | 15:37:41 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:42 INFO - PROCESS | 12008 | RSS: Main: 161107968 15:37:42 INFO - PROCESS | 12008 | 15:37:44 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:45 INFO - PROCESS | 12008 | RSS: Main: 161423360 15:37:45 INFO - PROCESS | 12008 | 15:37:47 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:48 INFO - PROCESS | 12008 | RSS: Main: 161755136 15:37:48 INFO - PROCESS | 12008 | 15:37:51 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:51 INFO - PROCESS | 12008 | RSS: Main: 161542144 15:37:51 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57903/tests/kraken/driver.html?testName=ai-astar) 15:37:53 INFO - PROCESS | 12008 | RSS: Main: 162328576 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | __start_tp_report 15:37:53 INFO - PROCESS | 12008 | _x_x_mozilla_page_load 15:37:53 INFO - PROCESS | 12008 | _x_x_mozilla_page_load_details 15:37:53 INFO - PROCESS | 12008 | |i|pagename|runs| 15:37:53 INFO - PROCESS | 12008 | |0;ai-astar;110;103;111;111;111;110;111;110;110;110 15:37:53 INFO - PROCESS | 12008 | |1;audio-beat-detection;159;125;152;174;133;160;163;127;185;127 15:37:53 INFO - PROCESS | 12008 | |2;audio-dft;161;161;161;161;167;161;161;163;160;164 15:37:53 INFO - PROCESS | 12008 | |3;audio-fft;75;76;76;183;74;75;75;75;163;74 15:37:53 INFO - PROCESS | 12008 | |4;audio-oscillator;87;86;141;88;87;86;140;87;86;136 15:37:53 INFO - PROCESS | 12008 | |5;imaging-gaussian-blur;118;117;117;118;117;117;116;117;117;117 15:37:53 INFO - PROCESS | 12008 | |6;imaging-darkroom;149;148;146;146;147;147;147;148;148;149 15:37:53 INFO - PROCESS | 12008 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;95;95 15:37:53 INFO - PROCESS | 12008 | |8;json-parse-financial;53;54;54;54;56;64;54;54;54;57 15:37:53 INFO - PROCESS | 12008 | |9;json-stringify-tinderbox;59;60;60;60;60;60;61;60;59;60 15:37:53 INFO - PROCESS | 12008 | |10;stanford-crypto-aes;75;78;75;76;77;85;77;78;110;77 15:37:53 INFO - PROCESS | 12008 | |11;stanford-crypto-ccm;128;130;133;117;117;122;132;126;138;122 15:37:53 INFO - PROCESS | 12008 | |12;stanford-crypto-pbkdf2;155;156;155;155;160;153;159;152;156;151 15:37:53 INFO - PROCESS | 12008 | |13;stanford-crypto-sha256-iterative;61;63;62;62;65;63;68;60;63;62 15:37:53 INFO - PROCESS | 12008 | __end_tp_report 15:37:53 INFO - PROCESS | 12008 | __start_cc_report 15:37:53 INFO - PROCESS | 12008 | _x_x_mozilla_cycle_collect,872 15:37:53 INFO - PROCESS | 12008 | __end_cc_report 15:37:53 INFO - PROCESS | 12008 | __startTimestamp1467326273565__endTimestamp 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | ------- Summary: start ------- 15:37:53 INFO - PROCESS | 12008 | Number of tests: 14 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.41 (2.2%) stddev-sans-first:2.55 15:37:53 INFO - PROCESS | 12008 | Values: 110.0 103.0 111.0 111.0 111.0 110.0 111.0 110.0 110.0 110.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:159.50 stddev:21.41 (13.4%) stddev-sans-first:22.48 15:37:53 INFO - PROCESS | 12008 | Values: 159.0 125.0 152.0 174.0 133.0 160.0 163.0 127.0 185.0 127.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.00 stddev:2.11 (1.3%) stddev-sans-first:2.20 15:37:53 INFO - PROCESS | 12008 | Values: 161.0 161.0 161.0 161.0 167.0 161.0 161.0 163.0 160.0 164.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:41.59 (55.5%) stddev-sans-first:43.51 15:37:53 INFO - PROCESS | 12008 | Values: 75.0 76.0 76.0 183.0 74.0 75.0 75.0 75.0 163.0 74.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.50 stddev:25.29 (29.2%) stddev-sans-first:26.21 15:37:53 INFO - PROCESS | 12008 | Values: 87.0 86.0 141.0 88.0 87.0 86.0 140.0 87.0 86.0 136.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 15:37:53 INFO - PROCESS | 12008 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 15:37:53 INFO - PROCESS | 12008 | Values: 149.0 148.0 146.0 146.0 147.0 147.0 147.0 148.0 148.0 149.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:37:53 INFO - PROCESS | 12008 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:3.24 (6.0%) stddev-sans-first:3.32 15:37:53 INFO - PROCESS | 12008 | Values: 53.0 54.0 54.0 54.0 56.0 64.0 54.0 54.0 54.0 57.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 15:37:53 INFO - PROCESS | 12008 | Values: 59.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 59.0 60.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:77.00 stddev:10.64 (13.8%) stddev-sans-first:11.08 15:37:53 INFO - PROCESS | 12008 | Values: 75.0 78.0 75.0 76.0 77.0 85.0 77.0 78.0 110.0 77.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:129.00 stddev:7.00 (5.4%) stddev-sans-first:7.40 15:37:53 INFO - PROCESS | 12008 | Values: 128.0 130.0 133.0 117.0 117.0 122.0 132.0 126.0 138.0 122.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.50 stddev:2.82 (1.8%) stddev-sans-first:2.99 15:37:53 INFO - PROCESS | 12008 | Values: 155.0 156.0 155.0 155.0 160.0 153.0 159.0 152.0 156.0 151.0 15:37:53 INFO - PROCESS | 12008 | 15:37:53 INFO - PROCESS | 12008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:2.23 (3.5%) stddev-sans-first:2.26 15:37:53 INFO - PROCESS | 12008 | Values: 61.0 63.0 62.0 62.0 65.0 63.0 68.0 60.0 63.0 62.0 15:37:53 INFO - PROCESS | 12008 | -------- Summary: end -------- 15:37:53 INFO - PROCESS | 12008 | 15:37:54 INFO - TEST-INFO | 12008: exit 0 15:37:54 INFO - TEST-OK | kraken | took 61595ms 15:37:54 INFO - SUITE-END | took 1172s 15:37:54 INFO - Completed test suite (00:19:32) 15:37:54 INFO - javascript benchmark 15:37:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7723.038957647947, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3402.234497238121, 3404.914877128073, 3433.3648275069113, 3441.741869359798, 3443.07037099983, 5677.403872593381, 5685.573581981353, 5692.459216374443, 5726.997775389305, 5778.682172480512, 5696.373398926125, 5772.509336706375, 5773.682447465399, 5779.306483222019, 5788.565857560689, 5181.455947125563, 5218.373795144588, 5265.236540701615, 5284.524392804647, 5326.387465441466, 5172.534471897528, 5187.974060129694, 5301.549368303698, 5310.15037593985, 5311.097113490716, 5189.040027594907, 5218.321618189649, 5223.294855194538, 5251.422343542207, 5290.920636190441, 5232.398274198478, 5315.096433606296, 5329.227262046981, 5332.413434522199, 5333.653312534711, 5045.798168073273, 5168.9224661630105, 5229.581633469314, 5287.312649355597, 5287.550558202557, 5473.17902314652, 5480.835574932758, 5510.311211098613, 5612.0, 5623.550115990711, 6092.3603021682975, 6142.078688196806, 6143.877122457526, 6145.047517634774, 6156.445919867188, 6055.27336719592, 6125.816225513242, 6185.845353866144, 6230.43926046658, 6241.781537646206, 5698.572607054446, 5770.903528329604, 5802.071668533014, 5830.650160990312, 5840.561957853178, 6309.495240380758, 6314.526410519229, 6321.620702757849, 6326.145970294044, 6354.269259035178, 5837.7956771513645, 5977.402259773988, 6004.669743164168, 6053.667048312297, 6059.394060593905, 6128.625347140816, 6155.938440615537, 6165.445109940038, 6165.907511387333, 6174.6912654368, 6097.298810636745, 6103.969480152571, 6162.322144564095, 6169.043798211284, 6195.938040619536, 5918.437748413894, 6114.449699527064, 6119.2350956130485, 6123.038605230386, 6164.568480206342, 4714.15145273854, 4721.173794585934, 4723.669343146015, 4748.881277968009, 4750.714957102585, 4196.538380778112, 4201.579842015774, 4215.641670458045, 4231.386448964883, 4250.553691862372, 5750.2524671793235, 5952.136940143655, 5977.880442391215, 6012.518998480111, 6083.543734219951, 6123.4351415035735, 6197.132401463708, 6197.938020619736, 6300.2754683212015, 6302.180716506917, 5844.327902291206, 6063.181470501514, 6067.484263837623, 6070.3929607038945, 6074.119252708332, 5251.186066159751, 5255.973720131375, 5299.2316114164005, 5311.176767601028, 5332.0, 6424.614523128534, 6449.484041276781, 6451.580647257913, 6454.257760357619, 6501.869962600722, 6006.918754624209, 6212.77275040153, 6223.097650840512, 6227.813165605039, 6231.2522497300615, 6220.098085777447, 6300.086487459384, 6315.336889626707, 6347.96826015867, 6355.745770169141, 6031.69841507914, 6035.5473339500595, 6070.1501789750355, 6072.8785424292155, 6092.756289748538, 6008.1588577598295, 6143.262808463013, 6194.287656919331, 6195.287541932736, 6211.875762484635, 6003.759849606142, 6043.153958445909, 6079.3312735598165, 6102.603330783485, 6126.142340072304, 6026.9698651508215, 6044.0, 6045.727942242522, 6046.334903160561, 6077.270727512727, 5745.597808153556, 5859.121131830259, 5869.090291004901, 5959.553033522417, 5969.104634304889, 5998.940010599838, 6048.969755151196, 6072.817815465543, 6082.817515474543, 6090.9390906090375, 5903.26209223847, 5933.110033495011, 5935.436133567304, 5937.584369094122, 5951.196588460675], "value": 5687.798788616061, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.9116632505127, 626.9655168965706, 631.5673763472025, 650.9869802603945, 654.1822721598003, 44669.77665111674, 45992.0, 46664.53335466644, 49752.253716194195, 50026.0, 48017.51982480183, 48634.75682621591, 48756.75621621896, 48783.0, 48794.0, 9012.50431226284, 9183.54082295886, 9196.034416386283, 9204.355695101345, 9207.723768286929, 8993.730188094334, 9059.909400905972, 9082.54587270637, 9084.454932704026, 9092.181703646671, 9078.954605226965, 9155.450672959643, 9172.357934944557, 9185.770355741093, 9193.080691930787, 9146.314026447977, 9161.450312981242, 9163.35856490046, 9183.540822958892, 9197.816043679122, 8806.471611703319, 8885.378023538355, 8910.376273660846, 8924.107589241088, 8989.41568798026, 44688.77655611734, 44778.552214477764, 44972.3254151188, 45363.319550206776, 45470.77264613689, 3795.7912314822674, 3800.7909564973916, 3807.3908174691915, 3846.38457846746, 3884.2231553689376, 33892.32215355679, 34300.656993430246, 34821.0, 35103.29793404143, 35782.28435431303, 4829.396325459317, 4855.198892182786, 4874.2201247800185, 4967.081089998362, 5054.545090941796, 368687.6262474762, 371179.0, 372820.0, 373055.0, 374737.99999999726, 37817.62182378196, 38956.0, 65422.0, 65963.67018164879, 66036.33963660398, 40236.79881600632, 40388.0, 40458.19083618311, 40530.39204411877, 40590.79704601458, 13442.32788360578, 13457.25985070811, 13479.797803032963, 13486.460541578423, 13526.391312390966, 13344.999125065659, 13354.065215435021, 13366.131201471873, 13420.261885596386, 13464.730705385837, 9098.181163695166, 9104.453732776055, 9174.67888623895, 9255.259579233645, 9261.583228754722, 3444.483327500845, 3493.94759078614, 3519.384107781128, 3523.119220194951, 3571.2143328467696, 1075.3924032921375, 1075.704181350135, 1085.2511766880828, 1111.4664960818852, 1204.2413279633774, 33907.66092339094, 33923.66076339205, 34189.658103418646, 34265.82867085699, 34515.82742086273, 1122.1359553144196, 1169.91225658076, 1242.2298175131295, 1256.4597223194114, 1260.1053252190864, 17238.224279907434, 17529.01917422422, 17535.64928701419, 17571.297148113932, 17701.203445844967, 890346.0, 1003497.0, 1009791.0, 1010533.0, 1021142.0, 58274.708626456595, 58641.120383194284, 59134.0, 59187.40812591905, 59421.70289148526, 1466.4280930437137, 1471.3084850120426, 1491.4705279625578, 1492.1718446262212, 1498.3257534109475, 33650.15874603154, 33769.83115084409, 33858.32283354369, 33863.83068084742, 34605.48091778676, 56958.0, 59970.100448492434, 61936.38063619306, 62168.37831621807, 68407.65796170988, 508037.0, 510583.0, 514157.0, 515239.0, 516541.0, 48219.75890120527, 48331.75834120807, 48708.269375960095, 48922.755386224264, 49036.75481622569, 53367.4663253378, 53858.730706346214, 54366.184507233214, 55007.72496137494, 55425.060122895506, 43821.409123382335, 44456.77771611121, 44651.0, 45545.54454455546, 45620.54379456296, 43843.05795118862, 43912.560874390845, 44674.776626117964, 44952.550474494834, 45714.085718286115, 44133.33799992938, 45298.54701452943, 45595.54404455913, 45689.08621827478, 45744.0, 38354.23291534098, 38376.0, 38998.610013899495, 39124.217515650096, 40139.799301004474, 29485.410291793614, 29662.0, 29930.85034574813, 30151.698483015767, 30214.0], "value": 20770.089316055277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.2702405909954, 432.7511680783549, 434.5220257716511, 438.69510690070416, 440.3421119485137, 18442.354517591888, 19650.606987860236, 20187.899060504715, 20571.691424628607, 20789.792102078976, 17546.0, 17926.19332130054, 18949.715754263696, 18995.43013709591, 19175.520611984706, 5421.9457805421935, 5619.690916999563, 5670.68811215383, 5671.432856714337, 5679.801206957757, 5551.444855514436, 5629.324481062258, 5679.346875109353, 6007.579469437142, 6022.939770602282, 6046.697665116749, 6061.969690151565, 6069.969650151743, 6070.726817293233, 6087.543434242428, 6021.789237376693, 6023.337432882379, 6109.847253818646, 6123.112148738408, 6138.386161383871, 5253.921191182136, 5954.642721436684, 5974.820755377345, 5978.8206353809455, 5983.222181116427, 23492.7650723494, 23737.050517979435, 23739.169129080572, 23986.52026959451, 24024.15915442951, 2529.544681957247, 2699.163259389576, 2862.6278583784183, 3060.709232622897, 3066.9233269168226, 10126.038026387556, 10227.89772102277, 10332.94833525835, 10373.740656483573, 12440.0, 1774.476529423823, 1826.3607737291975, 1857.368494711791, 1890.225007746831, 1935.7483527141521, 79841.0, 83908.0, 84783.0, 85265.0, 85468.57265713695, 11516.539338426537, 11547.76904461906, 11661.18371713989, 11710.824337634942, 11947.880521194851, 16226.837731622769, 16278.918605406898, 16289.429869954494, 16407.507774766775, 16528.586785330222, 8396.622152003052, 8472.74581762548, 8516.06323304436, 8678.652853885775, 8718.782030449289, 8149.388795840336, 8153.388495862834, 8211.260986511243, 8272.420930534805, 8287.254147126787, 4967.205247160509, 4997.075541024922, 5015.573676237488, 5040.31955685985, 5164.56101231392, 1689.222957439567, 1840.3742727472722, 1843.8709290349816, 2049.928252511155, 2093.0895060648363, 969.6703120938914, 1008.9192864570816, 1064.122099268107, 1079.6383211624193, 1113.716002419378, 18514.907425462785, 19620.803791962182, 19639.410817675493, 19735.802641973685, 19929.10319035647, 1004.8191325561469, 1042.598599539183, 1079.0450451350612, 1111.9332840029624, 1125.6004118537965, 10883.510242039127, 11063.22557420989, 11209.831852522218, 11261.324320540794, 11263.718407039889, 489391.0, 490257.0, 501365.0, 505560.0, 505938.0, 60589.0, 83793.58103209444, 91461.54269228611, 93449.0, 96903.0, 981.2983716642635, 1045.4459136657583, 1066.5147357952112, 1068.631322193842, 1077.1275267033727, 18257.45227643173, 18270.0, 18699.813001870352, 18733.90633046826, 18832.62334753325, 38216.04459888525, 42212.0, 42732.14535709331, 44696.55303446924, 45360.31959520544, 49908.25137622866, 61254.0, 61496.0, 61638.69180654068, 61936.38063619487, 8521.53131577769, 8834.779130521789, 8970.147835955573, 8974.775630609025, 11842.407879606157, 9285.396449231048, 9424.293178011814, 13018.0, 13180.209187448783, 13434.529791457642, 8544.530050847263, 8688.56720118368, 8918.24194943437, 8926.598303076247, 9043.954780226057, 8614.526201058752, 8622.78443038929, 8677.913220867964, 8717.65129394817, 8850.513221772864, 9095.544712845913, 9200.585973631069, 9211.769705757142, 9214.308926830381, 9217.58520866576, 12664.493420263087, 12828.743425131259, 12852.614421567368, 12922.483100675867, 12989.610311690287, 12183.817242741543, 12334.629961101182, 12344.13591048618, 12393.814092788796, 12614.684632884251], "value": 9387.028340605613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.269322072016, 1556.5252597957622, 1773.4236373178712, 1874.9062546872653, 1878.9906050469745, 8249.175082491747, 9400.858987115198, 9462.337636365457, 10190.235732320078, 10192.235582331326, 9423.15191632753, 9743.366681165719, 9812.55843487043, 9835.60657573698, 9893.950530247339, 2462.113639089926, 2490.887910044052, 2507.6238564215423, 2516.069054449856, 2524.823262371635, 2448.865312407817, 2511.4349271413967, 2513.861737604431, 2517.0309430869156, 2520.420303330235, 2456.6683497727845, 2459.32368598635, 2501.4121681404854, 2506.6616006839026, 2523.4826860493645, 2492.2149522900227, 2540.771330580247, 2551.107112510625, 2577.9226623201334, 2579.239124458289, 2419.697537807774, 2460.5447992121335, 2461.9015239390583, 2465.2234546117916, 2470.468849197431, 9808.754781130458, 9835.409875407428, 9850.655227067018, 9898.90101098987, 9941.0, 5698.145278208261, 5722.484976352107, 5748.971255143698, 5785.045467497858, 5845.2401187845735, 3677.9771125880925, 3805.2389522095414, 3806.809659517013, 3817.6945844332386, 3908.5505166905887, 1232.4577186038114, 1266.6073517209602, 1272.338384040303, 1274.796032634774, 1291.2704322058007, 14290.785638215435, 14304.284785760774, 14309.141451512838, 14331.71336573273, 14341.0, 5065.670731402447, 5079.161938280216, 5081.644284900021, 5084.44071152173, 5164.896702066013, 11830.40847957616, 11853.46659400329, 11855.0, 11870.762584748256, 11873.228240164362, 5796.62321949072, 5806.65160090396, 5809.622374545641, 5819.301683797971, 5823.970880145572, 4405.251107311765, 5133.0, 5233.869153271199, 5247.842564723064, 5297.5232229099565, 4210.410542524049, 4278.058827058042, 4317.568243175658, 4335.1329734053315, 4347.8260869564865, 1334.5729366602593, 1367.4803574641771, 1370.4792178971927, 1388.4585011845388, 1395.379056319928, 1010.0909181736496, 1028.753099256188, 1035.1977217656226, 1036.9585216591402, 1044.6865940217904, 6340.841478963062, 6632.071509988606, 6638.634875081917, 6658.43403310724, 6715.4291885190305, 972.8589354543693, 1005.5625802775816, 1022.4172221833633, 1038.7299302181336, 1055.6094245129352, 4331.913361732748, 4450.354698568754, 4457.754823484739, 4462.0, 4480.238359478896, 12261.26432414058, 12645.241285522898, 12651.114421990373, 12673.619791406272, 12695.68260793469, 11774.175807693551, 12301.938490307492, 12329.075319350904, 12638.0, 12658.620241392773, 9105.590248438835, 9162.129597688208, 9192.356535042616, 9235.815283694288, 9287.535623218948, 6463.15978922737, 6706.899396509154, 6856.211535673262, 6953.79138625842, 6984.895226571707, 11366.261193022427, 11469.426528673366, 11623.0, 11713.238639488405, 11765.0, 11466.0, 11615.941920290345, 11752.471138798604, 11880.168388212742, 12032.977196938358, 7700.0, 8563.95718021431, 8857.0, 8932.732018039469, 8950.0, 9763.0, 9805.705828825146, 9814.607415703293, 9874.160696340605, 9904.702858914245, 8503.8724419135, 8676.696315628922, 8721.65113395457, 8755.25580325654, 8789.868151977853, 8163.632636531252, 8191.549464779494, 8536.402451828313, 8614.267787238156, 8634.654613815377, 7749.186335434698, 7775.494592851446, 7865.882011769942, 7867.763967080997, 7873.645685944261, 5698.686572238566, 5802.274715660543, 5914.526837852875, 5946.226990491208, 5999.5800293979, 5367.302250707383, 5406.540444062299, 5804.709764511673, 5874.765009399576, 5879.323877754113], "value": 5149.338992288855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.4760383227076, 358.50168266110114, 360.0351059161448, 369.8982779735574, 374.9118957045094, 5513.531349835269, 5677.545796336293, 5784.5661575381855, 5785.82642520725, 5830.7667693292215, 5635.6055076144585, 5706.0, 5710.5717071219615, 5721.856953576153, 5735.684537350444, 4450.26570615848, 4484.847273308814, 4486.97756511217, 4487.663425243103, 4510.233260345733, 4432.756198409086, 4486.977565112186, 4502.932456013163, 4516.683832131752, 4529.980754330282, 4412.691111622188, 4412.779361031951, 4427.1367083418745, 4430.556944305576, 4463.598276155145, 4294.184105020036, 4457.955420445803, 4463.464384273875, 4483.282674772021, 4483.327500874895, 3886.1839013807135, 3900.395438707005, 3921.901952451183, 3928.017995501125, 3936.626020528045, 5470.124780035176, 5503.834884953458, 5507.7246137692955, 5513.42109078549, 5514.338279406497, 4859.781309841065, 5058.822941197077, 5065.1642478990925, 5100.515451032146, 5126.359205099363, 5985.610935289193, 6011.669358185298, 6018.916595012896, 6026.517878569748, 6031.849203769897, 4359.367891655724, 4364.607185353333, 4369.1480161368545, 4377.474703035656, 4377.846775362847, 6113.296970848321, 6258.280297765769, 6281.7173227204885, 6314.463270622003, 6315.557910946236, 4400.733622184577, 4418.403515525363, 4424.557544245614, 4426.468823741172, 4449.844255451108, 4508.436445444319, 4517.706349087299, 4524.705894116872, 4528.366028755977, 4534.682572219913, 5021.84934451967, 5099.388073431212, 5101.897962040813, 5137.280780690707, 5142.971405718871, 5805.216295800097, 6007.476859718929, 6033.461467325892, 6057.878842423127, 6062.333143354227, 1524.4969160177116, 1537.6770878115497, 1549.5506303172178, 1554.0, 1568.9764653529978, 985.6944347252374, 990.3364745620452, 992.3599278465349, 1004.2016596805557, 1023.5138309303021, 5276.129438642581, 5283.6037297202865, 5302.496262855023, 5318.9202161967605, 5409.43200963901, 5558.888822223533, 5595.888082238333, 5628.690422026828, 5640.323161220597, 5642.6614403135945, 5320.707361095099, 5344.385395679469, 5657.915131273035, 6009.36901625323, 6023.0, 3277.737780977516, 3306.470964645645, 3333.633300336961, 3340.88306909257, 3356.3455126250146, 6238.376162383816, 6429.6463694496315, 6486.383793539606, 6495.902561461582, 6543.993844708802, 6304.65324407162, 6309.14826498426, 6392.456641185551, 6406.935930640727, 6418.19772528434, 6363.936360636334, 6510.414062734377, 6562.5406221564035, 6584.617230381674, 6585.209774827052, 6091.177691011657, 6112.541559383153, 6196.442320191204, 6279.434850863444, 6327.746890124344, 6160.10678451631, 6171.981623032149, 6228.131560531913, 6231.0, 6248.562600617913, 6306.972653126433, 6523.347665233438, 6532.902006469812, 6535.451174042222, 6548.377904099103, 4399.802008909671, 4417.580329868657, 4436.26801577736, 4451.799669014967, 4468.3074123510905, 5985.827511418781, 6101.694915254131, 6254.530910181846, 6264.5301602379095, 6281.214848143982, 6034.69826508664, 6045.491121184835, 6059.545534085049, 6064.878702425838, 6076.574639775174, 6013.218281623361, 6025.758969641165, 6037.245344331958, 6049.274087109575, 6085.1785009023215, 5671.319441667027, 6003.609765365237, 6029.728662210299, 6030.7889223876955, 6052.515798736179, 6108.953500577356, 6141.539384546266, 6149.907751383644, 6153.907691384722, 6175.814725558061, 5703.914441283301, 5949.281698938164, 5983.551233657406, 5986.742784015406, 5987.221661184019], "value": 4585.923665480679, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.7698067560405, 814.6822739131736, 847.0428415890043, 863.2446609216935, 909.4815954905698, 15299.235038248085, 16604.584885377855, 16632.584185395357, 17176.22706978186, 17257.91371043143, 15809.130497822614, 16056.678866422693, 16068.83931160688, 16104.919475402636, 16146.273417696202, 819.19309480162, 845.7293666026874, 848.8896443462341, 849.9405041647087, 851.953142577158, 848.3128665780737, 851.9872201916976, 854.4147259127486, 854.9871751923727, 858.5621333120091, 903.8960519540271, 908.418612088264, 909.5406819556115, 910.3718434280325, 911.5351170902854, 900.333753022765, 904.9638014479413, 906.071276941134, 906.5648488725449, 907.5144797533321, 656.1044174701545, 659.9208095028579, 663.0948754949459, 664.5447868210243, 666.6566718140161, 15578.688426231525, 15669.608259793482, 15701.450449234222, 15748.527544173694, 15759.921200393925, 15268.38926442941, 15284.082955022623, 15312.923435382752, 15462.690746185013, 15765.842341576552, 12691.301978391184, 12717.809232861515, 12723.809142862865, 12727.109102362838, 12739.61781146567, 4059.6752259819145, 4077.041895154636, 4077.633013028812, 4134.37984302354, 4147.771872547009, 67694.3230567693, 75723.0, 76782.0, 79781.0, 79794.20205797926, 12360.381980900918, 12755.808662870064, 12768.425420856083, 12848.100632955604, 12911.483540658457, 22604.09583616637, 22685.2060177893, 22711.545769084856, 22740.772592273865, 22765.772342276698, 9493.90506094944, 9580.425174489554, 9621.90378096224, 9678.661246856467, 9729.173020293212, 5242.68543887368, 5307.52232299095, 5347.41178470368, 5405.5135037846785, 5503.614746967673, 3977.5624681285035, 4100.897477563085, 4106.507219133723, 4107.8973025674, 4112.753234805921, 671.8589096289834, 676.1683129750435, 679.7688785812848, 702.2170280137711, 706.4348521183033, 720.7765592666291, 835.7242110103651, 852.3436953545735, 854.4446110028407, 865.0959747064333, 10907.454627268764, 11159.72100697489, 11246.437678116225, 11272.436378181223, 11326.0, 744.7840126363402, 774.156169774948, 781.7029528779141, 827.6275675945849, 836.1137194573771, 5262.973685131627, 5281.656692314988, 5365.651232669864, 5449.6730196188355, 5456.48163424474, 116428.41785791017, 116990.41504792421, 117679.41160294315, 119311.40344298223, 123845.38077309736, 64809.0, 65029.34970650328, 71911.28088719046, 97440.0, 101330.0, 89645.55177224072, 89648.5517572408, 91084.0, 92195.5390223058, 92598.0, 9783.804323913624, 9918.950405247928, 9959.253056020683, 9971.551280192263, 10061.39631622105, 38453.80773096117, 45883.54116458793, 53057.469425306794, 53124.73437632942, 55328.17007744968, 69620.6518967402, 75990.0, 76389.0, 77174.61412692901, 77670.0, 13087.476500939856, 13101.803472948104, 13194.472221111431, 13433.462661493431, 13441.731165376834, 14160.504382346568, 14972.7005459888, 15043.0, 15047.623809404853, 15398.07611543311, 14575.489857854924, 14782.556523304318, 15031.323590438238, 15223.695526089195, 15830.841691583397, 15227.619309517351, 15978.840211597735, 15990.120543369761, 16140.435084771976, 16304.918475407547, 14973.925130374279, 15052.54842354731, 15802.60493487672, 16092.758608620647, 16369.09969951664, 12017.699557510783, 12272.570460033856, 12371.628851134481, 12553.748925021631, 12698.238105713686, 11816.704582385166, 12424.627261182179, 12452.049868137035, 12760.361981900682, 12764.489420423079], "value": 8102.1740488379955, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 152.0, 174.0, 133.0, 160.0, 163.0, 127.0, 185.0, 127.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 167.0, 161.0, 161.0, 163.0, 160.0, 164.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 183.0, 74.0, 75.0, 75.0, 75.0, 163.0, 74.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 141.0, 88.0, 87.0, 86.0, 140.0, 87.0, 86.0, 136.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 56.0, 64.0, 54.0, 54.0, 54.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 75.0, 76.0, 77.0, 85.0, 77.0, 78.0, 110.0, 77.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 133.0, 117.0, 117.0, 122.0, 132.0, 126.0, 138.0, 122.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 155.0, 155.0, 160.0, 153.0, 159.0, 152.0, 156.0, 151.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 65.0, 63.0, 68.0, 60.0, 63.0, 62.0], "value": 62.9, "unit": "score"}]}]} 15:37:54 INFO - Return code: 0 15:37:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:37:54 ERROR - # TBPL SUCCESS # 15:37:54 INFO - Running post-action listener: _resource_record_post_action 15:37:54 INFO - ##### 15:37:54 INFO - ##### Finished run-tests step (success) 15:37:54 INFO - ##### 15:37:54 INFO - Running post-run listener: _resource_record_post_run 15:37:54 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 294912; Write bytes: 509972480; Read time: 172; Write time: 337468 15:37:54 INFO - TinderboxPrint: CPU usage
13.4% 15:37:54 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 172 15:37:54 INFO - TinderboxPrint: I/O write bytes / time
509,972,480 / 337,468 15:37:54 INFO - TinderboxPrint: CPU idle
8,224.0 (86.6%) 15:37:54 INFO - TinderboxPrint: CPU user
1,213.3 (12.8%) 15:37:54 INFO - TinderboxPrint: Swap in / out
0 / 0 15:37:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 260386816; Read time: 0; Write time: 223292 15:37:55 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 270336; Write bytes: 249585664; Read time: 152; Write time: 114176 15:37:55 INFO - Running post-run listener: _upload_blobber_files 15:37:55 INFO - Blob upload gear active. 15:37:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:55 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:37:55 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:37:55 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:37:55 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:56 INFO - (blobuploader) - INFO - Done attempting. 15:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:57 INFO - (blobuploader) - INFO - Done attempting. 15:37:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:37:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:01 INFO - (blobuploader) - INFO - Done attempting. 15:38:01 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:01 INFO - Return code: 0 15:38:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ac29a001dc4ec157ab17916ee467c0bf5158fb8089d67003dce9319bd3354358f6478f67b36bd52bb43410194e01ff9791afe5cf4b2dfd5ed19e33bb435b4d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f62232db77ab135dc41d9f87c21ecc0b03b29153ff463f79774f0ef276745f63dfb85fc680a97b3027e4930a9721d7b3fbcf54fb355d9fb875e007b62ee335f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f875deba1c57d6a7826d904fdb8b799b5cb0fe00d4bed9644aea0b3d48e3526468fe7dd80f1a90edae24009cc8bcd112800c51a9e4ef589ce5c52ec13102396"} 15:38:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:01 INFO - Contents: 15:38:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ac29a001dc4ec157ab17916ee467c0bf5158fb8089d67003dce9319bd3354358f6478f67b36bd52bb43410194e01ff9791afe5cf4b2dfd5ed19e33bb435b4d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f62232db77ab135dc41d9f87c21ecc0b03b29153ff463f79774f0ef276745f63dfb85fc680a97b3027e4930a9721d7b3fbcf54fb355d9fb875e007b62ee335f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f875deba1c57d6a7826d904fdb8b799b5cb0fe00d4bed9644aea0b3d48e3526468fe7dd80f1a90edae24009cc8bcd112800c51a9e4ef589ce5c52ec13102396"} 15:38:01 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:01 INFO - Copying logs to upload dir... 15:38:01 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.990026 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-30 15:38:01.586682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 15:38:01.592326) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005 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/6ac29a001dc4ec157ab17916ee467c0bf5158fb8089d67003dce9319bd3354358f6478f67b36bd52bb43410194e01ff9791afe5cf4b2dfd5ed19e33bb435b4d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f62232db77ab135dc41d9f87c21ecc0b03b29153ff463f79774f0ef276745f63dfb85fc680a97b3027e4930a9721d7b3fbcf54fb355d9fb875e007b62ee335f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f875deba1c57d6a7826d904fdb8b799b5cb0fe00d4bed9644aea0b3d48e3526468fe7dd80f1a90edae24009cc8bcd112800c51a9e4ef589ce5c52ec13102396"} build_url:https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/fiQ77NOuTEqyrs0vWJYCsg/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/6ac29a001dc4ec157ab17916ee467c0bf5158fb8089d67003dce9319bd3354358f6478f67b36bd52bb43410194e01ff9791afe5cf4b2dfd5ed19e33bb435b4d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f62232db77ab135dc41d9f87c21ecc0b03b29153ff463f79774f0ef276745f63dfb85fc680a97b3027e4930a9721d7b3fbcf54fb355d9fb875e007b62ee335f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f875deba1c57d6a7826d904fdb8b799b5cb0fe00d4bed9644aea0b3d48e3526468fe7dd80f1a90edae24009cc8bcd112800c51a9e4ef589ce5c52ec13102396"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 15:38:01.621840) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:38:01.622192) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467325047.885743-168804005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:38:01.708725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 15:38:01.709044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 15:38:01.709365) ========= ========= Total master_lag: 0.20 =========