builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1465217244.64 results: success (0) buildid: 20160606030219 builduid: 0acc48f2928c40b2966e671a0fa6ec10 revision: 0a3b6e2df6567d845f31c000c68dd67816c6153d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.641399) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.641843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.642122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.660242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.660543) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:47:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-06 05:47:24 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092192 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.773405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.773719) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014172 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:24.838459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 05:47:24.838787) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a3b6e2df6567d845f31c000c68dd67816c6153d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0a3b6e2df6567d845f31c000c68dd67816c6153d --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=9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:47:24,980 truncating revision to first 12 chars 2016-06-06 05:47:24,981 Setting DEBUG logging. 2016-06-06 05:47:24,981 attempt 1/10 2016-06-06 05:47:24,981 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a3b6e2df656?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:47:25,618 unpacking tar archive at: mozilla-central-0a3b6e2df656/testing/mozharness/ program finished with exit code 0 elapsedTime=1.015855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 05:47:25.872766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:25.873077) ========= script_repo_revision: 0a3b6e2df6567d845f31c000c68dd67816c6153d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:25.873455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:25.873727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:47:25.886927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-06 05:47:25.887198) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:47:26 INFO - MultiFileLogger online at 20160606 05:47:26 in /builds/slave/test 05:47:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:47:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:47:26 INFO - {'append_to_log': False, 05:47:26 INFO - 'base_work_dir': '/builds/slave/test', 05:47:26 INFO - 'blob_upload_branch': 'Firefox', 05:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:47:26 INFO - 'branch': 'Firefox', 05:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:47:26 INFO - 'config_files': ('talos/linux_config.py',), 05:47:26 INFO - 'default_actions': ('clobber', 05:47:26 INFO - 'read-buildbot-config', 05:47:26 INFO - 'download-and-extract', 05:47:26 INFO - 'populate-webroot', 05:47:26 INFO - 'create-virtualenv', 05:47:26 INFO - 'install', 05:47:26 INFO - 'run-tests'), 05:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:47:26 INFO - 'download_minidump_stackwalk': True, 05:47:26 INFO - 'download_symbols': 'ondemand', 05:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:47:26 INFO - 'installer_path': 'installer.exe', 05:47:26 INFO - 'log_level': 'info', 05:47:26 INFO - 'log_name': 'talos', 05:47:26 INFO - 'log_to_console': True, 05:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:47:26 INFO - 'opt_config_files': (), 05:47:26 INFO - 'pip_index': False, 05:47:26 INFO - 'sps_profile': False, 05:47:26 INFO - 'sps_profile_interval': 0, 05:47:26 INFO - 'suite': 'dromaeojs-e10s', 05:47:26 INFO - 'system_bits': '32', 05:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:47:26 INFO - 'title': 'talos-linux64-ix-022', 05:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:47:26 INFO - 'use_talos_json': True, 05:47:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:47:26 INFO - 'work_dir': 'build'} 05:47:26 INFO - ##### 05:47:26 INFO - ##### Running clobber step. 05:47:26 INFO - ##### 05:47:26 INFO - Running pre-action listener: _resource_record_pre_action 05:47:26 INFO - Running main action method: clobber 05:47:26 INFO - rmtree: /builds/slave/test/build 05:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:47:27 INFO - Running post-action listener: _resource_record_post_action 05:47:27 INFO - ##### 05:47:27 INFO - ##### Finished clobber step (success) 05:47:27 INFO - ##### 05:47:27 INFO - ##### 05:47:27 INFO - ##### Running read-buildbot-config step. 05:47:27 INFO - ##### 05:47:27 INFO - Running pre-action listener: _resource_record_pre_action 05:47:27 INFO - Running main action method: read_buildbot_config 05:47:27 INFO - Using buildbot properties: 05:47:27 INFO - { 05:47:27 INFO - "project": "", 05:47:27 INFO - "product": "firefox", 05:47:27 INFO - "script_repo_revision": "production", 05:47:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:47:27 INFO - "repository": "", 05:47:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:47:27 INFO - "buildid": "20160606030219", 05:47:27 INFO - "stage_platform": "linux64-pgo", 05:47:27 INFO - "basedir": "/builds/slave/test", 05:47:27 INFO - "nightly_build": "True", 05:47:27 INFO - "buildnumber": 239, 05:47:27 INFO - "slavename": "talos-linux64-ix-022", 05:47:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:47:27 INFO - "platform": "ubuntu64_hw", 05:47:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:47:27 INFO - "branch": "mozilla-central", 05:47:27 INFO - "repo_path": "mozilla-central", 05:47:27 INFO - "revision": "0a3b6e2df6567d845f31c000c68dd67816c6153d", 05:47:27 INFO - "pgo_build": "True", 05:47:27 INFO - "builduid": "0acc48f2928c40b2966e671a0fa6ec10", 05:47:27 INFO - "slavebuilddir": "test" 05:47:27 INFO - } 05:47:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:47:27 INFO - Running post-action listener: _resource_record_post_action 05:47:27 INFO - ##### 05:47:27 INFO - ##### Finished read-buildbot-config step (success) 05:47:27 INFO - ##### 05:47:27 INFO - ##### 05:47:27 INFO - ##### Running download-and-extract step. 05:47:27 INFO - ##### 05:47:27 INFO - Running pre-action listener: _resource_record_pre_action 05:47:27 INFO - Running main action method: download_and_extract 05:47:27 INFO - mkdir: /builds/slave/test/build/tests 05:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:27 INFO - https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:47:29 INFO - Downloaded 1361 bytes. 05:47:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:47:29 INFO - Using the following test package requirements: 05:47:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:47:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:47:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'jsshell-linux-x86_64.zip'], 05:47:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:47:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:47:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:47:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:47:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:47:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:47:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:47:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:47:29 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')]} 05:47:29 INFO - https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:47:30 INFO - Downloaded 24443300 bytes. 05:47:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:47:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:47:32 INFO - Return code: 0 05:47:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:47:32 INFO - https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:47:34 INFO - Downloaded 24443300 bytes. 05:47:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:47:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:47:35 INFO - Return code: 0 05:47:35 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')]} 05:47:35 INFO - https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:47:37 INFO - Downloaded 10833369 bytes. 05:47:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:47:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:47:37 INFO - Return code: 0 05:47: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')]} 05:47:37 INFO - https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:47:38 INFO - Downloaded 59084384 bytes. 05:47:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:38 INFO - mkdir: /builds/slave/test/properties 05:47:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:47:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:47:38 INFO - Contents: 05:47:38 INFO - build_url:https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:47:39 INFO - Running post-action listener: _resource_record_post_action 05:47:39 INFO - Running post-action listener: set_extra_try_arguments 05:47:39 INFO - ##### 05:47:39 INFO - ##### Finished download-and-extract step (success) 05:47:39 INFO - ##### 05:47:39 INFO - ##### 05:47:39 INFO - ##### Running populate-webroot step. 05:47:39 INFO - ##### 05:47:39 INFO - Running pre-action listener: _resource_record_pre_action 05:47:39 INFO - Running main action method: populate_webroot 05:47:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:47:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:47:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:47:39 INFO - '--tppagecycles', 05:47:39 INFO - '7'], 05:47:39 INFO - 'tests': ['tsvgm']}}, 05:47:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:47:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:47:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:47:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:47:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:47:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['damp', 'tps']}, 05:47:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'tests': ['damp', 'tps']}, 05:47:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['dromaeo_dom']}, 05:47:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:47:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['a11yr', 05:47:39 INFO - 'ts_paint', 05:47:39 INFO - 'tpaint', 05:47:39 INFO - 'sessionrestore', 05:47:39 INFO - 'sessionrestore_no_auto_restore', 05:47:39 INFO - 'tabpaint']}, 05:47:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:47:39 INFO - 'ts_paint', 05:47:39 INFO - 'tpaint', 05:47:39 INFO - 'sessionrestore', 05:47:39 INFO - 'sessionrestore_no_auto_restore', 05:47:39 INFO - 'tabpaint']}, 05:47:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:47:39 INFO - 'ts_paint', 05:47:39 INFO - 'tpaint', 05:47:39 INFO - 'sessionrestore', 05:47:39 INFO - 'sessionrestore_no_auto_restore', 05:47:39 INFO - 'tabpaint']}, 05:47:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:47:39 INFO - 'ts_paint', 05:47:39 INFO - 'tpaint', 05:47:39 INFO - 'sessionrestore', 05:47:39 INFO - 'sessionrestore_no_auto_restore', 05:47:39 INFO - 'tabpaint']}, 05:47:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['a11yr', 05:47:39 INFO - 'ts_paint', 05:47:39 INFO - 'tpaint', 05:47:39 INFO - 'sessionrestore', 05:47:39 INFO - 'sessionrestore_no_auto_restore', 05:47:39 INFO - 'tabpaint']}, 05:47:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['a11yr', 05:47:39 INFO - 'ts_paint', 05:47:39 INFO - 'tpaint', 05:47:39 INFO - 'sessionrestore', 05:47:39 INFO - 'sessionrestore_no_auto_restore', 05:47:39 INFO - 'tabpaint']}, 05:47:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['tsvgx', 05:47:39 INFO - 'tsvgr_opacity', 05:47:39 INFO - 'tart', 05:47:39 INFO - 'tscrollx', 05:47:39 INFO - 'cart']}, 05:47:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:47:39 INFO - 'tsvgr_opacity', 05:47:39 INFO - 'tart', 05:47:39 INFO - 'tscrollx', 05:47:39 INFO - 'cart']}, 05:47:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'talos_options': ['--disable-e10s'], 05:47:39 INFO - 'tests': ['tp5o']}, 05:47:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'tests': ['tp5o']}, 05:47:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'talos_options': ['--disable-e10s', 05:47:39 INFO - '--xperf_path', 05:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:39 INFO - 'tests': ['tp5n']}, 05:47:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:47:39 INFO - 'talos_options': ['--xperf_path', 05:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:47:39 INFO - 'tests': ['tp5n']}}, 05:47:39 INFO - 'talos.zip': {'path': '', 05:47:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:47:39 INFO - Running post-action listener: _resource_record_post_action 05:47:39 INFO - ##### 05:47:39 INFO - ##### Finished populate-webroot step (success) 05:47:39 INFO - ##### 05:47:39 INFO - ##### 05:47:39 INFO - ##### Running create-virtualenv step. 05:47:39 INFO - ##### 05:47:39 INFO - Running pre-action listener: _resource_record_pre_action 05:47:39 INFO - Running main action method: create_virtualenv 05:47:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:47: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 05:47:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:47:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:47:39 INFO - Using real prefix '/usr' 05:47:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:47:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:47:42 INFO - Installing pip.................done. 05:47:42 INFO - Return code: 0 05:47:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:47: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 05:47: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 05:47:42 INFO - Using env: {'DISPLAY': ':0', 05:47:42 INFO - 'HOME': '/home/cltbld', 05:47:42 INFO - 'LANG': 'en_US.UTF-8', 05:47:42 INFO - 'LANGUAGE': 'en_US:en', 05:47:42 INFO - 'LOGNAME': 'cltbld', 05:47:42 INFO - 'MAIL': '/var/mail/cltbld', 05:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:42 INFO - 'MOZ_NO_REMOTE': '1', 05:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:42 INFO - 'NO_EM_RESTART': '1', 05:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:42 INFO - 'PWD': '/builds/slave/test', 05:47:42 INFO - 'SHELL': '/bin/bash', 05:47:42 INFO - 'SHLVL': '1', 05:47:42 INFO - 'TERM': 'linux', 05:47:42 INFO - 'TMOUT': '86400', 05:47:42 INFO - 'USER': 'cltbld', 05:47:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:42 INFO - '_': '/tools/buildbot/bin/python'} 05:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47: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 05:47:42 INFO - Cleaning up... 05:47:42 INFO - Return code: 0 05:47:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:47: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 05:47: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 05:47:42 INFO - Using env: {'DISPLAY': ':0', 05:47:42 INFO - 'HOME': '/home/cltbld', 05:47:42 INFO - 'LANG': 'en_US.UTF-8', 05:47:42 INFO - 'LANGUAGE': 'en_US:en', 05:47:42 INFO - 'LOGNAME': 'cltbld', 05:47:42 INFO - 'MAIL': '/var/mail/cltbld', 05:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:42 INFO - 'MOZ_NO_REMOTE': '1', 05:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:42 INFO - 'NO_EM_RESTART': '1', 05:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:42 INFO - 'PWD': '/builds/slave/test', 05:47:42 INFO - 'SHELL': '/bin/bash', 05:47:42 INFO - 'SHLVL': '1', 05:47:42 INFO - 'TERM': 'linux', 05:47:42 INFO - 'TMOUT': '86400', 05:47:42 INFO - 'USER': 'cltbld', 05:47:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:42 INFO - '_': '/tools/buildbot/bin/python'} 05:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:42 INFO - Downloading/unpacking psutil>=3.1.1 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:47:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:44 INFO - Installing collected packages: psutil 05:47:44 INFO - Running setup.py install for psutil 05:47:44 INFO - building 'psutil._psutil_linux' extension 05:47:44 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 05:47: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 05:47:45 INFO - building 'psutil._psutil_posix' extension 05:47: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 05:47: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 05:47:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:47:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:47:45 INFO - Successfully installed psutil 05:47:45 INFO - Cleaning up... 05:47:45 INFO - Return code: 0 05:47:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:47: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 05:47: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 05:47:45 INFO - Using env: {'DISPLAY': ':0', 05:47:45 INFO - 'HOME': '/home/cltbld', 05:47:45 INFO - 'LANG': 'en_US.UTF-8', 05:47:45 INFO - 'LANGUAGE': 'en_US:en', 05:47:45 INFO - 'LOGNAME': 'cltbld', 05:47:45 INFO - 'MAIL': '/var/mail/cltbld', 05:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:45 INFO - 'MOZ_NO_REMOTE': '1', 05:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:45 INFO - 'NO_EM_RESTART': '1', 05:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:45 INFO - 'PWD': '/builds/slave/test', 05:47:45 INFO - 'SHELL': '/bin/bash', 05:47:45 INFO - 'SHLVL': '1', 05:47:45 INFO - 'TERM': 'linux', 05:47:45 INFO - 'TMOUT': '86400', 05:47:45 INFO - 'USER': 'cltbld', 05:47:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:45 INFO - '_': '/tools/buildbot/bin/python'} 05:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:47 INFO - Installing collected packages: mozsystemmonitor 05:47:47 INFO - Running setup.py install for mozsystemmonitor 05:47:47 INFO - Successfully installed mozsystemmonitor 05:47:47 INFO - Cleaning up... 05:47:47 INFO - Return code: 0 05:47:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:47: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 05:47: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 05:47:47 INFO - Using env: {'DISPLAY': ':0', 05:47:47 INFO - 'HOME': '/home/cltbld', 05:47:47 INFO - 'LANG': 'en_US.UTF-8', 05:47:47 INFO - 'LANGUAGE': 'en_US:en', 05:47:47 INFO - 'LOGNAME': 'cltbld', 05:47:47 INFO - 'MAIL': '/var/mail/cltbld', 05:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:47 INFO - 'MOZ_NO_REMOTE': '1', 05:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:47 INFO - 'NO_EM_RESTART': '1', 05:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:47 INFO - 'PWD': '/builds/slave/test', 05:47:47 INFO - 'SHELL': '/bin/bash', 05:47:47 INFO - 'SHLVL': '1', 05:47:47 INFO - 'TERM': 'linux', 05:47:47 INFO - 'TMOUT': '86400', 05:47:47 INFO - 'USER': 'cltbld', 05:47:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:47 INFO - '_': '/tools/buildbot/bin/python'} 05:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:47:47 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 05:47:47 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 05:47:47 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 05:47:47 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 05:47:47 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 05:47:47 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 05:47:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:50 INFO - warning: no files found matching '*.txt' 05:47:50 INFO - no previously-included directories found matching 'build' 05:47:50 INFO - no previously-included directories found matching 'dist' 05:47:50 INFO - no previously-included directories found matching '.git*' 05:47:50 INFO - Installing collected packages: jsonschema, functools32 05:47:50 INFO - Running setup.py install for functools32 05:47:50 INFO - warning: no files found matching '*.txt' 05:47:50 INFO - no previously-included directories found matching 'build' 05:47:50 INFO - no previously-included directories found matching 'dist' 05:47:50 INFO - no previously-included directories found matching '.git*' 05:47:50 INFO - Successfully installed jsonschema functools32 05:47:50 INFO - Cleaning up... 05:47:50 INFO - Return code: 0 05:47:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:47: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 05:47: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 05:47:50 INFO - Using env: {'DISPLAY': ':0', 05:47:50 INFO - 'HOME': '/home/cltbld', 05:47:50 INFO - 'LANG': 'en_US.UTF-8', 05:47:50 INFO - 'LANGUAGE': 'en_US:en', 05:47:50 INFO - 'LOGNAME': 'cltbld', 05:47:50 INFO - 'MAIL': '/var/mail/cltbld', 05:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:50 INFO - 'MOZ_NO_REMOTE': '1', 05:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:50 INFO - 'NO_EM_RESTART': '1', 05:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:50 INFO - 'PWD': '/builds/slave/test', 05:47:50 INFO - 'SHELL': '/bin/bash', 05:47:50 INFO - 'SHLVL': '1', 05:47:50 INFO - 'TERM': 'linux', 05:47:50 INFO - 'TMOUT': '86400', 05:47:50 INFO - 'USER': 'cltbld', 05:47:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:50 INFO - '_': '/tools/buildbot/bin/python'} 05:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:53 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 05:47:53 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 05:47:53 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 05:47:53 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 05:47:53 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 05:47:53 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 05:47:53 INFO - Downloading docopt-0.6.1.tar.gz 05:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:53 INFO - Running setup.py install for blobuploader 05:47:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:53 INFO - Running setup.py install for requests 05:47:53 INFO - Running setup.py install for docopt 05:47:53 INFO - Successfully installed blobuploader requests docopt 05:47:53 INFO - Cleaning up... 05:47:53 INFO - Return code: 0 05:47:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:47: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 05:47: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 05:47:53 INFO - Using env: {'DISPLAY': ':0', 05:47:53 INFO - 'HOME': '/home/cltbld', 05:47:53 INFO - 'LANG': 'en_US.UTF-8', 05:47:53 INFO - 'LANGUAGE': 'en_US:en', 05:47:53 INFO - 'LOGNAME': 'cltbld', 05:47:53 INFO - 'MAIL': '/var/mail/cltbld', 05:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:53 INFO - 'MOZ_NO_REMOTE': '1', 05:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:53 INFO - 'NO_EM_RESTART': '1', 05:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:53 INFO - 'PWD': '/builds/slave/test', 05:47:53 INFO - 'SHELL': '/bin/bash', 05:47:53 INFO - 'SHLVL': '1', 05:47:53 INFO - 'TERM': 'linux', 05:47:53 INFO - 'TMOUT': '86400', 05:47:53 INFO - 'USER': 'cltbld', 05:47:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:53 INFO - '_': '/tools/buildbot/bin/python'} 05:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:54 INFO - Running setup.py (path:/tmp/pip-wJoZSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:54 INFO - Running setup.py (path:/tmp/pip-BNu12D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:54 INFO - Running setup.py (path:/tmp/pip-IVCZkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:54 INFO - Running setup.py (path:/tmp/pip-ErJXpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:54 INFO - Running setup.py (path:/tmp/pip-wjiUKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:54 INFO - Running setup.py (path:/tmp/pip-k_9dB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:54 INFO - Running setup.py (path:/tmp/pip-R8xY4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:54 INFO - Running setup.py (path:/tmp/pip-N1UnES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:54 INFO - Running setup.py (path:/tmp/pip-bBEuDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:54 INFO - Running setup.py (path:/tmp/pip-bkiZJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:54 INFO - Running setup.py (path:/tmp/pip-ZppEIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:54 INFO - Running setup.py (path:/tmp/pip-OQFQp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:54 INFO - Running setup.py (path:/tmp/pip-odnrhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:55 INFO - Running setup.py (path:/tmp/pip-Kxn7OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:55 INFO - Running setup.py (path:/tmp/pip-H1UKs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:55 INFO - Running setup.py (path:/tmp/pip-_uG7nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:55 INFO - Running setup.py (path:/tmp/pip-_DrY_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:55 INFO - Running setup.py install for manifestparser 05:47:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:55 INFO - Running setup.py install for mozcrash 05:47:55 INFO - Running setup.py install for mozdebug 05:47:55 INFO - Running setup.py install for mozdevice 05:47:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:55 INFO - Running setup.py install for mozfile 05:47:55 INFO - Running setup.py install for mozhttpd 05:47:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:55 INFO - Running setup.py install for mozinfo 05:47:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Running setup.py install for mozInstall 05:47:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Running setup.py install for mozleak 05:47:56 INFO - Running setup.py install for mozlog 05:47:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Running setup.py install for moznetwork 05:47:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Running setup.py install for mozprocess 05:47:56 INFO - Running setup.py install for mozprofile 05:47:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Running setup.py install for mozrunner 05:47:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:56 INFO - Running setup.py install for mozscreenshot 05:47:56 INFO - Running setup.py install for moztest 05:47:57 INFO - Running setup.py install for mozversion 05:47:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:57 INFO - Cleaning up... 05:47:57 INFO - Return code: 0 05:47:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47: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')]} 05:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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')]} 05:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:47: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 05:47: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 05:47:57 INFO - Using env: {'DISPLAY': ':0', 05:47:57 INFO - 'HOME': '/home/cltbld', 05:47:57 INFO - 'LANG': 'en_US.UTF-8', 05:47:57 INFO - 'LANGUAGE': 'en_US:en', 05:47:57 INFO - 'LOGNAME': 'cltbld', 05:47:57 INFO - 'MAIL': '/var/mail/cltbld', 05:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:57 INFO - 'MOZ_NO_REMOTE': '1', 05:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:57 INFO - 'NO_EM_RESTART': '1', 05:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:57 INFO - 'PWD': '/builds/slave/test', 05:47:57 INFO - 'SHELL': '/bin/bash', 05:47:57 INFO - 'SHLVL': '1', 05:47:57 INFO - 'TERM': 'linux', 05:47:57 INFO - 'TMOUT': '86400', 05:47:57 INFO - 'USER': 'cltbld', 05:47:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:57 INFO - '_': '/tools/buildbot/bin/python'} 05:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:57 INFO - Running setup.py (path:/tmp/pip-4YVXyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:57 INFO - Running setup.py (path:/tmp/pip-GVKnes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:57 INFO - Running setup.py (path:/tmp/pip-GEndkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:57 INFO - Running setup.py (path:/tmp/pip-QEYGQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:57 INFO - Running setup.py (path:/tmp/pip-Muy6MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:57 INFO - Running setup.py (path:/tmp/pip-JZo7p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:57 INFO - Running setup.py (path:/tmp/pip-mBakNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:57 INFO - Running setup.py (path:/tmp/pip-qb4FNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47: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)) 05:47:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:57 INFO - Running setup.py (path:/tmp/pip-pAGZqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:58 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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:58 INFO - Running setup.py (path:/tmp/pip-NexGMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47: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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:58 INFO - Running setup.py (path:/tmp/pip-orHxDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47: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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:58 INFO - Running setup.py (path:/tmp/pip-CKWfFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47: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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:58 INFO - Running setup.py (path:/tmp/pip-dYIqa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47: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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:58 INFO - Running setup.py (path:/tmp/pip-0tz2mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47: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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:58 INFO - Running setup.py (path:/tmp/pip-HeoUp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47: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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:58 INFO - Running setup.py (path:/tmp/pip-La0vhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47: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)) 05:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:58 INFO - Running setup.py (path:/tmp/pip-83SGT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47: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)) 05:47: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)) 05:47: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)) 05:47: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)) 05:47: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)) 05:47: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)) 05:47:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:47: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 05:48:00 INFO - Downloading blessings-1.6.tar.gz 05:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:00 INFO - Installing collected packages: blessings 05:48:00 INFO - Running setup.py install for blessings 05:48:00 INFO - Successfully installed blessings 05:48:00 INFO - Cleaning up... 05:48:00 INFO - Return code: 0 05:48:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:00 INFO - Reading from file tmpfile_stdout 05:48:00 INFO - Current package versions: 05:48:00 INFO - argparse == 1.2.1 05:48:00 INFO - blessings == 1.6 05:48:00 INFO - blobuploader == 1.2.4 05:48:00 INFO - docopt == 0.6.1 05:48:00 INFO - functools32 == 3.2.3-2 05:48:00 INFO - jsonschema == 2.5.1 05:48:00 INFO - manifestparser == 1.1 05:48:00 INFO - mozInstall == 1.12 05:48:00 INFO - mozcrash == 0.17 05:48:00 INFO - mozdebug == 0.1 05:48:00 INFO - mozdevice == 0.48 05:48:00 INFO - mozfile == 1.2 05:48:00 INFO - mozhttpd == 0.7 05:48:00 INFO - mozinfo == 0.9 05:48:00 INFO - mozleak == 0.1 05:48:00 INFO - mozlog == 3.2 05:48:00 INFO - moznetwork == 0.27 05:48:00 INFO - mozprocess == 0.22 05:48:00 INFO - mozprofile == 0.28 05:48:00 INFO - mozrunner == 6.11 05:48:00 INFO - mozscreenshot == 0.1 05:48:00 INFO - mozsystemmonitor == 0.3 05:48:00 INFO - moztest == 0.7 05:48:00 INFO - mozversion == 1.4 05:48:00 INFO - psutil == 3.1.1 05:48:00 INFO - requests == 1.2.3 05:48:00 INFO - wsgiref == 0.1.2 05:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48:01 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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:48:01 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 05:48:01 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 05:48:01 INFO - Using env: {'DISPLAY': ':0', 05:48:01 INFO - 'HOME': '/home/cltbld', 05:48:01 INFO - 'LANG': 'en_US.UTF-8', 05:48:01 INFO - 'LANGUAGE': 'en_US:en', 05:48:01 INFO - 'LOGNAME': 'cltbld', 05:48:01 INFO - 'MAIL': '/var/mail/cltbld', 05:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:01 INFO - 'MOZ_NO_REMOTE': '1', 05:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:01 INFO - 'NO_EM_RESTART': '1', 05:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:01 INFO - 'PWD': '/builds/slave/test', 05:48:01 INFO - 'SHELL': '/bin/bash', 05:48:01 INFO - 'SHLVL': '1', 05:48:01 INFO - 'TERM': 'linux', 05:48:01 INFO - 'TMOUT': '86400', 05:48:01 INFO - 'USER': 'cltbld', 05:48:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:01 INFO - '_': '/tools/buildbot/bin/python'} 05:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48: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)) 05:48:01 INFO - Cleaning up... 05:48:01 INFO - Return code: 0 05:48:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:48: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 05:48: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 05:48:01 INFO - Using env: {'DISPLAY': ':0', 05:48:01 INFO - 'HOME': '/home/cltbld', 05:48:01 INFO - 'LANG': 'en_US.UTF-8', 05:48:01 INFO - 'LANGUAGE': 'en_US:en', 05:48:01 INFO - 'LOGNAME': 'cltbld', 05:48:01 INFO - 'MAIL': '/var/mail/cltbld', 05:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:01 INFO - 'MOZ_NO_REMOTE': '1', 05:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:01 INFO - 'NO_EM_RESTART': '1', 05:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:01 INFO - 'PWD': '/builds/slave/test', 05:48:01 INFO - 'SHELL': '/bin/bash', 05:48:01 INFO - 'SHLVL': '1', 05:48:01 INFO - 'TERM': 'linux', 05:48:01 INFO - 'TMOUT': '86400', 05:48:01 INFO - 'USER': 'cltbld', 05:48:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:01 INFO - '_': '/tools/buildbot/bin/python'} 05:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:48:01 INFO - Cleaning up... 05:48:01 INFO - Return code: 0 05:48:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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')]} 05:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:48: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 0x7f24a6e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a03350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', '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 05:48: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 05:48: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 05:48:01 INFO - Using env: {'DISPLAY': ':0', 05:48:01 INFO - 'HOME': '/home/cltbld', 05:48:01 INFO - 'LANG': 'en_US.UTF-8', 05:48:01 INFO - 'LANGUAGE': 'en_US:en', 05:48:01 INFO - 'LOGNAME': 'cltbld', 05:48:01 INFO - 'MAIL': '/var/mail/cltbld', 05:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:01 INFO - 'MOZ_NO_REMOTE': '1', 05:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:01 INFO - 'NO_EM_RESTART': '1', 05:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:01 INFO - 'PWD': '/builds/slave/test', 05:48:01 INFO - 'SHELL': '/bin/bash', 05:48:01 INFO - 'SHLVL': '1', 05:48:01 INFO - 'TERM': 'linux', 05:48:01 INFO - 'TMOUT': '86400', 05:48:01 INFO - 'USER': 'cltbld', 05:48:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:01 INFO - '_': '/tools/buildbot/bin/python'} 05:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:01 INFO - Downloading/unpacking flake8 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:48:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:48:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48: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 05:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:48:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:04 INFO - no previously-included directories found matching 'docs/_build' 05:48:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:48:04 INFO - Running setup.py install for pep8 05:48:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:48:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:48:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:48:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:48:04 INFO - no previously-included directories found matching 'docs/_build' 05:48:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:48:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:48:04 INFO - Cleaning up... 05:48:04 INFO - Return code: 0 05:48:04 INFO - Running post-action listener: _resource_record_post_action 05:48:04 INFO - Running post-action listener: _start_resource_monitoring 05:48:04 INFO - Starting resource monitoring. 05:48:04 INFO - ##### 05:48:04 INFO - ##### Finished create-virtualenv step (success) 05:48:04 INFO - ##### 05:48:04 INFO - ##### 05:48:04 INFO - ##### Running install step. 05:48:04 INFO - ##### 05:48:04 INFO - Running pre-action listener: _resource_record_pre_action 05:48:04 INFO - Running main action method: install 05:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:04 INFO - Reading from file tmpfile_stdout 05:48:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:05 INFO - Reading from file tmpfile_stdout 05:48:05 INFO - Output received: 05:48:05 INFO - Usage: mozinstall [options] installer 05:48:05 INFO - Options: 05:48:05 INFO - -h, --help show this help message and exit 05:48:05 INFO - -d DEST, --destination=DEST 05:48:05 INFO - Directory to install application into. [default: 05:48:05 INFO - "/builds/slave/test"] 05:48:05 INFO - --app=APP Application being installed. [default: firefox] 05:48:05 INFO - mkdir: /builds/slave/test/build/application 05:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:48:21 INFO - Reading from file tmpfile_stdout 05:48:21 INFO - Output received: 05:48:21 INFO - /builds/slave/test/build/application/firefox/firefox 05:48:21 INFO - Running post-action listener: _resource_record_post_action 05:48:21 INFO - ##### 05:48:21 INFO - ##### Finished install step (success) 05:48:21 INFO - ##### 05:48:21 INFO - ##### 05:48:21 INFO - ##### Running run-tests step. 05:48:21 INFO - ##### 05:48:21 INFO - Running pre-action listener: _resource_record_pre_action 05:48:21 INFO - Running main action method: run_tests 05:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:48:21 INFO - Python 2.7.3 05:48:21 INFO - Return code: 0 05:48:21 INFO - grabbing minidump binary from tooltool 05:48:21 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')]} 05:48:21 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 0x1a921c0>, '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 0x1a930c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a93550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:48:21 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 05:48:21 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 05:48:21 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 05:48:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:48:21 INFO - Return code: 0 05:48:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:48:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:48:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:48:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:48:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:48:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:48:22 INFO - Return code: 0 05:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 05:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 05:48:22 INFO - Using env: {'DISPLAY': ':0', 05:48:22 INFO - 'HOME': '/home/cltbld', 05:48:22 INFO - 'LANG': 'en_US.UTF-8', 05:48:22 INFO - 'LANGUAGE': 'en_US:en', 05:48:22 INFO - 'LOGNAME': 'cltbld', 05:48:22 INFO - 'MAIL': '/var/mail/cltbld', 05:48:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:48:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:22 INFO - 'MOZ_NO_REMOTE': '1', 05:48:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:22 INFO - 'NO_EM_RESTART': '1', 05:48:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:22 INFO - 'PWD': '/builds/slave/test', 05:48:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:48:22 INFO - 'SHELL': '/bin/bash', 05:48:22 INFO - 'SHLVL': '1', 05:48:22 INFO - 'TERM': 'linux', 05:48:22 INFO - 'TMOUT': '86400', 05:48:22 INFO - 'USER': 'cltbld', 05:48:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290', 05:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:22 INFO - '_': '/tools/buildbot/bin/python'} 05:48:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 05:48:23 INFO - mozversion application_buildid: 20160606030219 05:48:23 INFO - mozversion application_changeset: 0a3b6e2df6567d845f31c000c68dd67816c6153d 05:48:23 INFO - mozversion application_display_name: Nightly 05:48:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:48:23 INFO - mozversion application_name: Firefox 05:48:23 INFO - mozversion application_remotingname: firefox 05:48:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:48:23 INFO - mozversion application_vendor: Mozilla 05:48:23 INFO - mozversion application_version: 49.0a1 05:48:23 INFO - mozversion platform_buildid: 20160606030219 05:48:23 INFO - mozversion platform_changeset: 0a3b6e2df6567d845f31c000c68dd67816c6153d 05:48:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:48:23 INFO - mozversion platform_version: 49.0a1 05:48:23 INFO - using testdate: 1465217303 05:48:23 INFO - actual date: 1465217303 05:48:23 INFO - starting webserver on 'localhost:36096' 05:48:23 INFO - SUITE-START | Running 2 tests 05:48:23 INFO - TEST-START | dromaeo_css 05:48:23 INFO - operating with platform_type : linux_ 05:48:23 INFO - Initialising browser for dromaeo_css test... 05:48:23 INFO - TEST-INFO | started process 12856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_Mf7Y/profile http://localhost:36096/getInfo.html) 05:48:27 INFO - PROCESS | 12856 | __metrics Screen width/height:1600/1200 05:48:27 INFO - PROCESS | 12856 | colorDepth:24 05:48:27 INFO - PROCESS | 12856 | Browser inner width/height: 1024/697 05:48:27 INFO - PROCESS | 12856 | __metrics 05:48:28 ERROR - PROCESS | 12856 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 05:48:29 INFO - TEST-INFO | 12856: exit 0 05:48:29 INFO - Browser initialized. 05:48:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:48:29 INFO - TEST-INFO | started process 12977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_Mf7Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:41 INFO - PROCESS | 12977 | RSS: Main: 167034880 05:48:41 INFO - PROCESS | 12977 | 05:49:30 INFO - PROCESS | 12977 | 1465217370667 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] 05:51:37 INFO - PROCESS | 12977 | Cycle 1(1): loaded http://localhost:36096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36096/tests/dromaeo/cssquery-ext.html) 05:51:39 INFO - PROCESS | 12977 | RSS: Main: 171503616 05:51:39 INFO - PROCESS | 12977 | 05:54:41 INFO - PROCESS | 12977 | Cycle 1(1): loaded http://localhost:36096/tests/dromaeo/cssquery-ext.html (next: http://localhost:36096/tests/dromaeo/cssquery-jquery.html) 05:54:41 INFO - PROCESS | 12977 | RSS: Main: 170168320 05:54:41 INFO - PROCESS | 12977 | 05:57:43 INFO - PROCESS | 12977 | Cycle 1(1): loaded http://localhost:36096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36096/tests/dromaeo/cssquery-mootools.html) 05:57:44 INFO - PROCESS | 12977 | RSS: Main: 171851776 05:57:44 INFO - PROCESS | 12977 | 06:00:46 INFO - PROCESS | 12977 | Cycle 1(1): loaded http://localhost:36096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36096/tests/dromaeo/cssquery-prototype.html) 06:00:46 INFO - PROCESS | 12977 | RSS: Main: 169062400 06:00:46 INFO - PROCESS | 12977 | 06:03:49 INFO - PROCESS | 12977 | Cycle 1(1): loaded http://localhost:36096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36096/tests/dromaeo/cssquery-yui.html) 06:03:49 INFO - PROCESS | 12977 | RSS: Main: 170688512 06:03:49 INFO - PROCESS | 12977 | 06:06:52 INFO - PROCESS | 12977 | Cycle 1(1): loaded http://localhost:36096/tests/dromaeo/cssquery-yui.html (next: http://localhost:36096/tests/dromaeo/cssquery-dojo.html) 06:06:52 INFO - PROCESS | 12977 | RSS: Main: 172318720 06:06:52 INFO - PROCESS | 12977 | 06:06:52 INFO - PROCESS | 12977 | __start_tp_report 06:06:52 INFO - PROCESS | 12977 | _x_x_mozilla_page_load 06:06:52 INFO - PROCESS | 12977 | _x_x_mozilla_page_load_details 06:06:52 INFO - PROCESS | 12977 | |i|pagename|runs| 06:06:52 INFO - PROCESS | 12977 | |0;dojo.html;3124.0940127363065;3125;3145.543896135062;3163.256634690847;3168.6672899345567;5345.385280692722;5357.651752636076;5389.892202155955;5416.187571864218;5453.672779633225;5174.197999310113;5296.126139187039;5329.467053294668;5349.358077030762;5461.18082287657;4817.710937343753;4837.854864354057;4890.877728056809;4904.926426103611;4983.6013118950395;658.2460438172703;4747.359106520627;4819.42166939966;4838.975805120969;4938.876528086791;4912.042151780404;4921.63087768417;4923.433805112404;4931.728754918496;4948.05986862495;4886.218205087204;4932;4944.98627781304;4954.801807927679;4970.577500912391;4839.806407743686;4903.607711383081;4905.3132561441425;4918.16391213491;4925.236588328815;5363.490468405495;5363.6245462817615;5394.91907621386;5425.945740542584;5430.348358197002;5492.780288788444;5773.653580785166;5814.6511209327155;5851.093080572518;5880.882382352329;5850.561207909382;5876.147958546029;5913.733881975321;5944.4352786485215;5958.374370691058;5517.5585953123655;5518.978988887028;5524.723763811833;5525.254090697745;5528.44715528448;5699.886002279931;5891.204687367151;5915.053591425351;6048.637081775019;6061.6666083365835;5726.255586773693;5735.369109397963;5736.741846616912;5737.082066869364;5776.884462310731;5784.334801497797;5797.797077102281;5798;5805.82582522525;5810.244668193108;5525.613207075467;5699.686517241508;5746.712664366765;5751.741171647286;5779.075347944308;5720.1991721159075;5750.942490575125;5773.942260577424;5780.479756821906;5803.912941305884;4333.285007973649;4382.342648602735;4416.779161041935;4418.734875907456;4421.358902959053;3808.1622043151015;3840.423936409505;3885.378339465672;3902.3366027775346;3932.2135572885536;5528.530074943595;5542.473465020817;5545.639533430314;5599.412061733459;5612.7754889803955;5835.44563266489;5861.677607731615;5868.295804503401;5876.676782776988;5881.088431293157;5337.786488540492;5509.338879334506;5553.194786755897;5584.357798853102;5592.189132575753;5012.498750125032;5027;5034;5044.445111037783;5067.214581739836;5721.4278572143285;6005.069214271794;6009.188759517409;6009.549283803733;6015.218021657157;5745.913811292834;5779.566532510163;5783.884322313446;5820.243368362086;5822.854428639318;5996.790112346047;6005.819825405245;6018;6031.185789918305;6031.638101713911;5545.140503221845;5663.688497132697;5695.658260504383;5715.599908006399;5721.713914304185;5781.161731548817;5808.796692115756;5816.738246778989;5852.590318677651;5906.675132867734;5635.746391412315;5636.85907852307;5643.3510146332055;5678.346990096192;5685.744141513559;5463.945360546344;5558;5579.8884022320135;5683.943160568341;5716.485516303553;5531.170324451204;5542.750576223999;5546.889062218653;5547.472990065938;5573.108302671553;5596.1605759136455;5624.072028115315;5633.295838020247;5636.689982051026;5651.2935883014625;5392.784288628411;5524.364698059614;5543.1408131739645;5627.859303517281;5653.632513886584 06:06:53 INFO - PROCESS | 12977 | |1;ext.html;555.2836840475784;600.0489224579045;615.1971676961565;625.5371025441173;636.1348565950304;39002.60997390025;43119.137617247674;43383.13233735327;43427.78286108565;43573.564264357345;43600.56399436005;44439;44581.7770911145;44653.874228803994;44691.77654111733;8800.075992020842;8916.777080572972;8947.77630559238;8981.595828187714;8984.236339911082;8858.60136293865;8882.822343553125;8959.955200223989;8964.058773828752;8968.192862642361;8923.330750193729;9019.45883247004;9024.729258122266;9026.458412495238;9029.232515236214;8813.162749538784;8952.373333866632;8962.596683149273;8968.282537396992;9004.504752238625;8694.434861733967;8794.912050879473;8799.208071273551;8845.248153906925;8877.289816814638;40653.59346406528;41006.58993410058;41191.38212926809;41250.58749412497;41407;2984.7612191024664;3183.2360233544014;3572.589152247499;3590.0845284452557;3633.1462106404974;30327.545086823717;31047;31113.066608001795;31129;31183;3957.7427467214825;4047.655949244318;4152.709310348277;4157.792110394498;4178.498580170369;326871;330184;330826;330893.3455332732;333221;35672.821635891654;35902.64097359045;36214.45678314827;36289.63710362915;36301;33841.32317353639;35862.282754344764;36823.26353472916;37149;37182.81408592994;14625.414983400546;14647.194404307653;14661.780073298909;14666.63333416673;14671;12663.050271229511;12718.300493472947;12718.427670754838;12721.491140354283;12760.361981900867;8274.586270686563;8313.12712165226;8396.244338009608;8434.15658434164;8473.533955632376;3285;3296.4396052671104;3302.752293577991;3306.487494438366;3331.1672081979505;979.4906648542718;1038.383274149155;1132.5130194016488;1151.45305979659;1178.3754610056683;32554.83722581372;32563;32688.67311326904;32936.3412731744;33031.3393732124;1078.6494389323502;1104.5968221599219;1112.1492058575197;1120.6581992492368;1258.2387655468492;16681.332746690237;17300.134993250285;17325;17399.73900391495;17410.39063632767;541512;550159;556337;556438;556538;60660;60976.69511652413;60999.99999999911;61147.6942615293;61289.38710612926;1342.2282187741891;1367.1113776045452;1388.222595346609;1398.091240693537;1405.248192217159;31345.8432707835;32059.679403205668;32301.51547726833;32391.352172956882;32798.34403311873;52406.47593524169;52805.207921880436;53198.20202696885;53337;53448.465515344345;463207;472686;473438;474983;480484;28484;28810.567841482814;29203;29222;29295.56056659109;48583.5141648579;49232;49849.252261215384;50556.747216263684;50569;43313.783431082644;44008;44127.77936110299;44410;45124;42021.78989105035;42331.576684233994;42457.5754242466;42505.78747106368;43634;40318;42233.36649950192;42298.577014229464;42368.364474533526;42561.574384255764;35848.4622730654;38015.80992095022;38900.41649375205;39023.609763902;39044.804775975936;28329.893633910244;28778.28054298659;29330.266743330732;29561.556576651798;30065 06:06:53 INFO - PROCESS | 12977 | |2;jquery.html;382.4129960510616;383.1952898912283;392.8428628548581;398.5635728876879;411.9938200926987;17755.556111097212;19432.417027489162;19637;20114.396568102962;20224.39326820196;17969.19138638761;18499;18542.072896355163;18587.628247435045;19147.904260478714;5643.379228284885;5774.191613174159;5850.034744267191;5885.087811389241;5894.4989675877605;5704.629199102045;5758.165066065418;5786.103154011135;5804.2744656917885;5809.9709501452435;5607;5700.771720189196;5700.800471983482;5728.283964504437;5730.856728581798;5601.943980560183;5676.035074037403;5714.114312281603;5717.371089180187;5741.282339707515;4934.309196712463;5093.286939828427;5100.5409513143995;5122.923156152623;5151.124308867502;22096.88951555248;22180.778192218033;22289.777102229094;22427.439314017116;22861.942425181813;2407.3018824540864;2420;2455.889484973163;2466.580681284186;2504.1110405805857;14205.857941420556;14212.573622791333;14224.573262802132;14503.274836258144;14588.781168282378;1917.7027560728109;1930.5173706573357;1981.4650044487908;1998.810113039259;2020.6867935470025;71257;72524;73282;73561.6321918387;75343.62328188379;10279.948600257101;10345.948270258601;10412.2515894278;10535.367877927196;10640.46797660114;14414.063085899383;14526.564203073925;14538.781918271234;14629.487967921285;14639.560813175409;7575.886361704579;8203;8326.833463330699;8418.074011858691;8446.324294056461;7981.321587664997;8101.473404228706;8131.430799844073;8238.752837414888;8288.129746376664;6633.010096970889;6649.63427011519;6750.1224840771365;6760.9520524318805;6961.756338528127;1821.6903126468533;1856.3688345962437;1879.8872067675984;1915.1669023974616;1925.2395303854898;850.7617866997251;962.5187406296851;967.7725734452398;1024.5901639344322;1080.9675709728722;19341;19481.610367792564;19589.902050489658;19596.21615135407;19864.404067877986;1015.2081376526321;1024.5645600619707;1054.752133248686;1101.823708206683;1136.3749937534324;9233.798621627144;11278.379689117013;11310.321380717183;11314.151438642135;11355.772884542263;464460;464831;465091;508238;516981;77057;81255;81282;81367.59316203381;81681.18318816855;1062.7874425114853;1073.414988831089;1084.7505073833063;1088.9618863339904;1095.6767753512734;17117.65764684724;17234.65530689404;17246;17459.47621571355;17683.911580442014;29877.551836722032;36164.27671446609;37600.2479950394;37827.62172378351;38758.6124138755;50373.49626503688;50955.49044509508;51630.48369516407;51956;54139.18791218213;8619.612117454604;8668.219860212612;8821.60302786389;8824.955875220583;8851.734447966572;9686.418814871131;13386.799198011842;13420.664483387993;13863.306834658428;13876.236806975714;11350.772984540428;11776.528938842694;11880.702982425508;11882.584109556125;12020.939895300467;11844.348560829238;11878.287302761863;11931.522739090338;12031.819522706992;12219.144659874079;11759.647210583697;11882.108841836724;12069;12140.696482588006;12213.38933053326;8566.742997710078;8683.131686831266;8780.165884240987;8795.252403545514;8893.866592000995;11353.148513861659;12116.636500904988;12137.69655758613;12239.20445171061;12259.203151795105 06:06:53 INFO - PROCESS | 12977 | |3;mootools.html;1466.2229018620135;1516.1964158995731;1624.5694890853927;1747.423350294402;1774.1395423219744;7399.963000184992;7945.9602701986405;7979.441439099265;8439.620217090238;8489;8138.552379619118;8285.254327110559;8305.626246818907;8394.706185283516;8414.705485308;2236.3738153317017;2284.4403121235237;2295.472041430472;2297.3337732057685;2300.87345196015;2118.353902059871;2138.7112739780086;2168.04605973372;2172.3700126963163;2178.0525471419905;2094.9266775662854;2115.122224276931;2115.524007098398;2127.9042443090098;2153.3001774423374;2115.185653523389;2118.8410869184795;2127.0853532980736;2128.265748316828;2128.425325162213;2199.1533259695134;2226.4100013496436;2231.665250212465;2234.7318321801326;2245.8091062259728;8250.257476827115;8319.542425166614;8343.916560834376;8353.624086916103;8362.16378362165;4941.604671626261;5034;5035.496450354972;5050.924236136461;5053.115704751691;3070.8003979741247;3183.315587148751;3209.5667084943466;3223.7904536205306;3231.709146176832;1080.0837738107064;1107.9224454288203;1129.1982692288484;1135.1656532448644;1142.4744617475972;10946.233763636548;11119.72200694981;11160.720981975435;11408;11569.016633586156;4288.678349123828;4298.570142985739;4336.371226172188;4395.055063161436;4398.098389830077;9071.682491112912;9121.17909388145;9132.269418446509;9135.908640913638;9160.496172710566;4967.130752118364;4981.651284410129;5024.824131155392;5033.471485494044;5034.370703662043;4023.657989070903;4462.241418958784;4585.12882552314;4602.884927876763;4635.860924172281;3495.7727747696827;3504.7021003214504;3563.4120370139153;3590.6588874056924;3612.7832330060282;1034.3225187502198;1062.4315990944808;1067.6796960911695;1081.3619964221148;1091.5524634899812;914.8947870994788;954.1031430455349;979.6413617512197;983.8130755156641;992.9652462163934;5473.8357849264585;5567.55459563242;5571.0807716727095;5586.245856809279;5781.046127389018;394.0955507111187;395.40096753418595;395.52141908290713;403.9616236457532;413.97309174903535;3838.712096592711;3851.422286657024;3870.9225815484097;3877.592852750477;3932.606739326102;9976.800463990825;10269.486525673687;10276.280660353703;10315.845262320921;10330.483475826179;9846.310758246997;10116.08955194036;10125.746856328651;10138.341007834468;10166.593336266615;7752.6898924043535;7804.3756499479905;7834.843303134019;7845.6077196141105;7862.253085956825;5394.27177331071;5398.892022159456;5482.643628164156;5512.862178445571;5589.944100559105;9291.907080929104;9566;9577.664781732607;9605.663801767185;9650.565724542272;9541.522923853918;9599.808003840024;9853.359531630422;9981.45102019396;9995.950020249853;7226.927730722836;7868.291853733192;7982.161873003483;8129.430939834155;8190.877136842833;8287.875681864656;8309.916900830915;8338.374621903502;8345.457545259538;8368;7391.260873912781;7581.090269167735;7631.923680763121;7650.4644674872225;7715.768526944201;7154.534955227893;7425.480216384801;7440.181580026301;7452.217517160837;7523.172451030273;6890.20762612306;6897.931020689729;6947.23580406165;6964.129483814523;7000.439964802906;4666.160091183619;4704.482506924167;4767.570918617341;4801.327814105958;4824.517548245148;4949.950500494949;4975.701457912537;4986.376702912136;4991;5062.038212739568 06:06:53 INFO - PROCESS | 12977 | |4;prototype.html;324.75318757744117;326.59828411054394;326.7696274126741;334.56506541496066;337.3489165909796;5625.943740562599;5653.2016651757385;5671.2986104168795;5699.800506982257;5716.514096301809;5562.471565201299;5563.610547261683;5567.916481252784;5577.21918931349;5579.358373787016;4136.793160341986;4206.978965105171;4245;4322.610965013148;4330.285502892035;4245.639120674731;4290.97854510727;4296.3770253313405;4299.398084268205;4305.24658184818;4295.119500502406;4296.205202037633;4315.352697095445;4317.654587632997;4332.566743325658;4069.9186016279655;4282.978585107086;4304.289792184286;4305.849295274682;4339.761313127777;3749.325121478133;3749.531308586427;3767.8492860285555;3777.376732839078;3782.3569993101237;5341.545968592674;5364.785408583652;5421.268128802601;5422.457754224585;5439.4832490913695;4814.7833347499445;4853.294517611643;4863.19757240055;4890;4923.01539692063;5785;5814.557885688021;5815.912761308584;5842.707864606753;5863.5016023638045;4082.5713300103657;4128.2156390285745;4135.560019588427;4161.607075931352;4167.062316023063;5923.956235098884;6055.818325450244;6073.635581865102;6094.360092190301;6132.356102609207;4147.605977432139;4166;4185.330347144442;4186.162767446523;4196.594140962811;4229.133027729308;4244.893877653083;4264.147170565837;4267.25323068468;4268.274393353137;4674.789634466457;4935.580475659537;4944.381952255968;4957.702537847741;4964.255361695775;5827.504662103684;5883.588148829626;5894.17481552583;5957.791477298274;5973.6260660047565;1441.22894251577;1466.9266536673124;1472.8085348904788;1478.8538882366252;1481.1853480585635;912.4616476279027;915.404986758599;925.319889880937;961.8941916389192;969.0116081596873;5628.971855140698;5683.54531637468;5704.714764261853;5712.65724056558;5718.51392631631;6015.669138197353;6035.155078289043;6046.758129674852;6061.363556826558;6100.359462256488;5409.486098820685;5708.71456427177;5766.423357664284;5799.88400231993;5800.955827950925;3224.290656055664;3226.225705830631;3247.2044349134612;3250.333681595267;3257.397381484433;6149.016157414792;6280.514314555466;6298.1812364392335;6308.085327627468;6309.825942727011;6124.908126378108;6180.196574445294;6195.380461953859;6223.719932603044;6277.780277690259;6033.607815491979;6233.532485063638;6256.7810126645345;6272.466840318532;6297.937020629826;6042.277950784005;6058.515318774399;6064.696765161812;6078.179445774764;6083.422074902877;5939;5980.192673988956;6004.759809607567;6005.699715014319;6043.184170137151;6003.099535069775;6190.380961903774;6240;6256.90504161779;6293.150424692791;4232.492100947906;4246.745195288293;4253.936190957076;4268.87193384199;4292.635126014324;5811.506021988178;5924.6149000314845;6058.5758996871555;6106.236720409949;6123.755049797958;5801.593888427769;5820.1560773688425;5866.384029676993;5872.500837428866;5877.23595932526;5829.912551311649;5853.268341457318;5880.617759845596;5883.470487656132;5885.735141918538;5587.608867379245;5657.179708942263;5776.133579963039;5776.942230577641;5781.739821707949;5911.881762364643;5919.526437884872;5924.526037917042;5937.465628093492;5962.896864079986;5485.396606373216;5763.164341170423;5771.913421298768;5797.362290148165;5864.413558644102 06:06:53 INFO - PROCESS | 12977 | |5;yui.html;744.3301029073833;766.7004427495398;769.4306213402084;819.7376839411388;828.8300898315846;14563.199024053685;15692.921535392321;16013.19934003301;16100.275487603056;16139.579063140505;14104.153750774934;14485.348159332829;14488.782668259984;14509.49216777413;14699.044562103456;808.3250485844312;814.543855440955;817.8650522663753;824.4764574495209;824.9010118785754;787.3937068457284;809.8258874342015;813.3168138763438;815.7878951472601;825.8059356051323;859.3640705877636;861.1001503428931;864.2999170671776;864.723288547665;865.8571335729597;852.4970267542149;857.536930057765;859.2438653984516;861.1431625532573;861.1732736572898;620.1318154583574;622.4304761143549;623.0840664223584;623.1742940603718;625.4121126141413;15134.394624215018;15151.090934543963;15204.239788010666;15206.315715792816;15266.160361180131;14201.928990355085;14275.857241427557;14332.211728354936;14332.211728354936;14555.199464029474;12052.337121458317;12088.576899808464;12199.268043917393;12255.1421400502;12641.304728239944;3816.561095474028;3877;3887.8833634990997;4010.7794071326066;4050.25070361984;78358.6082069586;78789.60605196937;78792;79126.6043669778;79375;11013.809530913437;11125.94437027826;11202.831957520644;11324.886751132548;11478.253913495597;20939;21084;21094.78905210959;21143.577128457346;21197.470063248235;8482.151784821468;8536.061033286334;8624;8624.137586241326;8929;4924.261360795909;5034.34553508049;5063.088644044034;5177.068127737043;5177.8187763428095;3534.3638145134123;3631.5642122944887;3636.2182130841998;3651.507046548682;3659.0486473516544;607.5018484842387;608.5375114912698;610.1793088296234;617.5831313863214;620.2216218645661;647.3752828520501;728.3845150847526;746.8892064551192;774.9883751743729;775.5656832174001;9623;9667.903320966841;9827.557759900821;9902.653407130716;10013.79972400548;709.982250443743;722.288545782404;735.6395366270596;750.7560042986051;759.9012128423269;4488.192125417456;4523.5024147343765;4638.536146385334;4675.18184317743;4834.613230941516;68589.65705171542;115083.42458287823;115154;118368.40815795866;119053.40473297577;62388.37611623917;78788;98466;99262;99415.50292248493;87472;88037;88339.55830220936;88492.5575372119;89365.10634893698;8969.730908072768;9053.230475409664;9142.862857057016;9144.451332920045;9290.473546442474;42954;51021;51552.48447515477;53202.4679753213;53835.73082134564;44557.55442445534;50948.74525627348;73609.6319518399;74420;74492.62753686414;11842.46708898119;11997.580084696994;12034.097442691658;12105.273683579013;12315.75368492643;12680.23918564889;13364.599062028155;13938.233397163254;14182.716345673236;14322.785158222843;12318.260904345769;12772.233665980071;12857.935710321763;12965.935170324088;13090.280034597808;12977.935110324388;12989.350532473527;13288.667783305495;13449.394777235244;13784.586462406143;12258.325792081165;12570.622881313575;12590.559330423392;12632.557860474839;12703;10406.58373665045;10535.947320263349;10866.836997445203;11178.720531986766;11187.832182517432;9810.803783924424;10333.793324133325;10686.89313106859;10870.61952831647;11010.50452729645 06:06:53 INFO - PROCESS | 12977 | __end_tp_report 06:06:53 INFO - PROCESS | 12977 | __start_cc_report 06:06:53 INFO - PROCESS | 12977 | _x_x_mozilla_cycle_collect,347 06:06:53 INFO - PROCESS | 12977 | __end_cc_report 06:06:53 INFO - PROCESS | 12977 | __startTimestamp1465218412994__endTimestamp 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - PROCESS | 12977 | ------- Summary: start ------- 06:06:53 INFO - PROCESS | 12977 | Number of tests: 6 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - PROCESS | 12977 | [#0] dojo.html Cycles:165 Average:5349.26 Median:5573.11 stddev:720.68 (12.9%) stddev-sans-first:701.43 06:06:53 INFO - PROCESS | 12977 | Values: 3124.1 3125.0 3145.5 3163.3 3168.7 5345.4 5357.7 5389.9 5416.2 5453.7 5174.2 5296.1 5329.5 5349.4 5461.2 4817.7 4837.9 4890.9 4904.9 4983.6 658.2 4747.4 4819.4 4839.0 4938.9 4912.0 4921.6 4923.4 4931.7 4948.1 4886.2 4932.0 4945.0 4954.8 4970.6 4839.8 4903.6 4905.3 4918.2 4925.2 5363.5 5363.6 5394.9 5425.9 5430.3 5492.8 5773.7 5814.7 5851.1 5880.9 5850.6 5876.1 5913.7 5944.4 5958.4 5517.6 5519.0 5524.7 5525.3 5528.4 5699.9 5891.2 5915.1 6048.6 6061.7 5726.3 5735.4 5736.7 5737.1 5776.9 5784.3 5797.8 5798.0 5805.8 5810.2 5525.6 5699.7 5746.7 5751.7 5779.1 5720.2 5750.9 5773.9 5780.5 5803.9 4333.3 4382.3 4416.8 4418.7 4421.4 3808.2 3840.4 3885.4 3902.3 3932.2 5528.5 5542.5 5545.6 5599.4 5612.8 5835.4 5861.7 5868.3 5876.7 5881.1 5337.8 5509.3 5553.2 5584.4 5592.2 5012.5 5027.0 5034.0 5044.4 5067.2 5721.4 6005.1 6009.2 6009.5 6015.2 5745.9 5779.6 5783.9 5820.2 5822.9 5996.8 6005.8 6018.0 6031.2 6031.6 5545.1 5663.7 5695.7 5715.6 5721.7 5781.2 5808.8 5816.7 5852.6 5906.7 5635.7 5636.9 5643.4 5678.3 5685.7 5463.9 5558.0 5579.9 5683.9 5716.5 5531.2 5542.8 5546.9 5547.5 5573.1 5596.2 5624.1 5633.3 5636.7 5651.3 5392.8 5524.4 5543.1 5627.9 5653.6 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - PROCESS | 12977 | [#1] ext.html Cycles:180 Average:59811.59 Median:41220.98 stddev:122712.23 (297.7%) stddev-sans-first:122975.82 06:06:53 INFO - PROCESS | 12977 | Values: 555.3 600.0 615.2 625.5 636.1 39002.6 43119.1 43383.1 43427.8 43573.6 43600.6 44439.0 44581.8 44653.9 44691.8 8800.1 8916.8 8947.8 8981.6 8984.2 8858.6 8882.8 8960.0 8964.1 8968.2 8923.3 9019.5 9024.7 9026.5 9029.2 8813.2 8952.4 8962.6 8968.3 9004.5 8694.4 8794.9 8799.2 8845.2 8877.3 40653.6 41006.6 41191.4 41250.6 41407.0 2984.8 3183.2 3572.6 3590.1 3633.1 30327.5 31047.0 31113.1 31129.0 31183.0 3957.7 4047.7 4152.7 4157.8 4178.5 326871.0 330184.0 330826.0 330893.3 333221.0 35672.8 35902.6 36214.5 36289.6 36301.0 33841.3 35862.3 36823.3 37149.0 37182.8 14625.4 14647.2 14661.8 14666.6 14671.0 12663.1 12718.3 12718.4 12721.5 12760.4 8274.6 8313.1 8396.2 8434.2 8473.5 3285.0 3296.4 3302.8 3306.5 3331.2 979.5 1038.4 1132.5 1151.5 1178.4 32554.8 32563.0 32688.7 32936.3 33031.3 1078.6 1104.6 1112.1 1120.7 1258.2 16681.3 17300.1 17325.0 17399.7 17410.4 541512.0 550159.0 556337.0 556438.0 556538.0 60660.0 60976.7 61000.0 61147.7 61289.4 1342.2 1367.1 1388.2 1398.1 1405.2 31345.8 32059.7 32301.5 32391.4 32798.3 52406.5 52805.2 53198.2 53337.0 53448.5 463207.0 472686.0 473438.0 474983.0 480484.0 28484.0 28810.6 29203.0 29222.0 29295.6 48583.5 49232.0 49849.3 50556.7 50569.0 43313.8 44008.0 44127.8 44410.0 45124.0 42021.8 42331.6 42457.6 42505.8 43634.0 40318.0 42233.4 42298.6 42368.4 42561.6 35848.5 38015.8 38900.4 39023.6 39044.8 28329.9 28778.3 29330.3 29561.6 30065.0 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - PROCESS | 12977 | [#2] jquery.html Cycles:180 Average:28114.36 Median:2413.65 stddev:79439.74 (3291.3%) stddev-sans-first:79635.30 06:06:53 INFO - PROCESS | 12977 | Values: 382.4 383.2 392.8 398.6 412.0 17755.6 19432.4 19637.0 20114.4 20224.4 17969.2 18499.0 18542.1 18587.6 19147.9 5643.4 5774.2 5850.0 5885.1 5894.5 5704.6 5758.2 5786.1 5804.3 5810.0 5607.0 5700.8 5700.8 5728.3 5730.9 5601.9 5676.0 5714.1 5717.4 5741.3 4934.3 5093.3 5100.5 5122.9 5151.1 22096.9 22180.8 22289.8 22427.4 22861.9 2407.3 2420.0 2455.9 2466.6 2504.1 14205.9 14212.6 14224.6 14503.3 14588.8 1917.7 1930.5 1981.5 1998.8 2020.7 71257.0 72524.0 73282.0 73561.6 75343.6 10279.9 10345.9 10412.3 10535.4 10640.5 14414.1 14526.6 14538.8 14629.5 14639.6 7575.9 8203.0 8326.8 8418.1 8446.3 7981.3 8101.5 8131.4 8238.8 8288.1 6633.0 6649.6 6750.1 6761.0 6961.8 1821.7 1856.4 1879.9 1915.2 1925.2 850.8 962.5 967.8 1024.6 1081.0 19341.0 19481.6 19589.9 19596.2 19864.4 1015.2 1024.6 1054.8 1101.8 1136.4 9233.8 11278.4 11310.3 11314.2 11355.8 464460.0 464831.0 465091.0 508238.0 516981.0 77057.0 81255.0 81282.0 81367.6 81681.2 1062.8 1073.4 1084.8 1089.0 1095.7 17117.7 17234.7 17246.0 17459.5 17683.9 29877.6 36164.3 37600.2 37827.6 38758.6 50373.5 50955.5 51630.5 51956.0 54139.2 8619.6 8668.2 8821.6 8825.0 8851.7 9686.4 13386.8 13420.7 13863.3 13876.2 11350.8 11776.5 11880.7 11882.6 12020.9 11844.3 11878.3 11931.5 12031.8 12219.1 11759.6 11882.1 12069.0 12140.7 12213.4 8566.7 8683.1 8780.2 8795.3 8893.9 11353.1 12116.6 12137.7 12239.2 12259.2 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - PROCESS | 12977 | [#3] mootools.html Cycles:180 Average:5472.54 Median:4971.42 stddev:3114.32 (62.6%) stddev-sans-first:3108.51 06:06:53 INFO - PROCESS | 12977 | Values: 1466.2 1516.2 1624.6 1747.4 1774.1 7400.0 7946.0 7979.4 8439.6 8489.0 8138.6 8285.3 8305.6 8394.7 8414.7 2236.4 2284.4 2295.5 2297.3 2300.9 2118.4 2138.7 2168.0 2172.4 2178.1 2094.9 2115.1 2115.5 2127.9 2153.3 2115.2 2118.8 2127.1 2128.3 2128.4 2199.2 2226.4 2231.7 2234.7 2245.8 8250.3 8319.5 8343.9 8353.6 8362.2 4941.6 5034.0 5035.5 5050.9 5053.1 3070.8 3183.3 3209.6 3223.8 3231.7 1080.1 1107.9 1129.2 1135.2 1142.5 10946.2 11119.7 11160.7 11408.0 11569.0 4288.7 4298.6 4336.4 4395.1 4398.1 9071.7 9121.2 9132.3 9135.9 9160.5 4967.1 4981.7 5024.8 5033.5 5034.4 4023.7 4462.2 4585.1 4602.9 4635.9 3495.8 3504.7 3563.4 3590.7 3612.8 1034.3 1062.4 1067.7 1081.4 1091.6 914.9 954.1 979.6 983.8 993.0 5473.8 5567.6 5571.1 5586.2 5781.0 394.1 395.4 395.5 404.0 414.0 3838.7 3851.4 3870.9 3877.6 3932.6 9976.8 10269.5 10276.3 10315.8 10330.5 9846.3 10116.1 10125.7 10138.3 10166.6 7752.7 7804.4 7834.8 7845.6 7862.3 5394.3 5398.9 5482.6 5512.9 5589.9 9291.9 9566.0 9577.7 9605.7 9650.6 9541.5 9599.8 9853.4 9981.5 9996.0 7226.9 7868.3 7982.2 8129.4 8190.9 8287.9 8309.9 8338.4 8345.5 8368.0 7391.3 7581.1 7631.9 7650.5 7715.8 7154.5 7425.5 7440.2 7452.2 7523.2 6890.2 6897.9 6947.2 6964.1 7000.4 4666.2 4704.5 4767.6 4801.3 4824.5 4950.0 4975.7 4986.4 4991.0 5062.0 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - PROCESS | 12977 | [#4] prototype.html Cycles:180 Average:4926.50 Median:5706.71 stddev:1477.20 (25.9%) stddev-sans-first:1440.40 06:06:53 INFO - PROCESS | 12977 | Values: 324.8 326.6 326.8 334.6 337.3 5625.9 5653.2 5671.3 5699.8 5716.5 5562.5 5563.6 5567.9 5577.2 5579.4 4136.8 4207.0 4245.0 4322.6 4330.3 4245.6 4291.0 4296.4 4299.4 4305.2 4295.1 4296.2 4315.4 4317.7 4332.6 4069.9 4283.0 4304.3 4305.8 4339.8 3749.3 3749.5 3767.8 3777.4 3782.4 5341.5 5364.8 5421.3 5422.5 5439.5 4814.8 4853.3 4863.2 4890.0 4923.0 5785.0 5814.6 5815.9 5842.7 5863.5 4082.6 4128.2 4135.6 4161.6 4167.1 5924.0 6055.8 6073.6 6094.4 6132.4 4147.6 4166.0 4185.3 4186.2 4196.6 4229.1 4244.9 4264.1 4267.3 4268.3 4674.8 4935.6 4944.4 4957.7 4964.3 5827.5 5883.6 5894.2 5957.8 5973.6 1441.2 1466.9 1472.8 1478.9 1481.2 912.5 915.4 925.3 961.9 969.0 5629.0 5683.5 5704.7 5712.7 5718.5 6015.7 6035.2 6046.8 6061.4 6100.4 5409.5 5708.7 5766.4 5799.9 5801.0 3224.3 3226.2 3247.2 3250.3 3257.4 6149.0 6280.5 6298.2 6308.1 6309.8 6124.9 6180.2 6195.4 6223.7 6277.8 6033.6 6233.5 6256.8 6272.5 6297.9 6042.3 6058.5 6064.7 6078.2 6083.4 5939.0 5980.2 6004.8 6005.7 6043.2 6003.1 6190.4 6240.0 6256.9 6293.2 4232.5 4246.7 4253.9 4268.9 4292.6 5811.5 5924.6 6058.6 6106.2 6123.8 5801.6 5820.2 5866.4 5872.5 5877.2 5829.9 5853.3 5880.6 5883.5 5885.7 5587.6 5657.2 5776.1 5776.9 5781.7 5911.9 5919.5 5924.5 5937.5 5962.9 5485.4 5763.2 5771.9 5797.4 5864.4 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - PROCESS | 12977 | [#5] yui.html Cycles:180 Average:19943.67 Median:4879.44 stddev:28602.34 (586.2%) stddev-sans-first:28646.25 06:06:53 INFO - PROCESS | 12977 | Values: 744.3 766.7 769.4 819.7 828.8 14563.2 15692.9 16013.2 16100.3 16139.6 14104.2 14485.3 14488.8 14509.5 14699.0 808.3 814.5 817.9 824.5 824.9 787.4 809.8 813.3 815.8 825.8 859.4 861.1 864.3 864.7 865.9 852.5 857.5 859.2 861.1 861.2 620.1 622.4 623.1 623.2 625.4 15134.4 15151.1 15204.2 15206.3 15266.2 14201.9 14275.9 14332.2 14332.2 14555.2 12052.3 12088.6 12199.3 12255.1 12641.3 3816.6 3877.0 3887.9 4010.8 4050.3 78358.6 78789.6 78792.0 79126.6 79375.0 11013.8 11125.9 11202.8 11324.9 11478.3 20939.0 21084.0 21094.8 21143.6 21197.5 8482.2 8536.1 8624.0 8624.1 8929.0 4924.3 5034.3 5063.1 5177.1 5177.8 3534.4 3631.6 3636.2 3651.5 3659.0 607.5 608.5 610.2 617.6 620.2 647.4 728.4 746.9 775.0 775.6 9623.0 9667.9 9827.6 9902.7 10013.8 710.0 722.3 735.6 750.8 759.9 4488.2 4523.5 4638.5 4675.2 4834.6 68589.7 115083.4 115154.0 118368.4 119053.4 62388.4 78788.0 98466.0 99262.0 99415.5 87472.0 88037.0 88339.6 88492.6 89365.1 8969.7 9053.2 9142.9 9144.5 9290.5 42954.0 51021.0 51552.5 53202.5 53835.7 44557.6 50948.7 73609.6 74420.0 74492.6 11842.5 11997.6 12034.1 12105.3 12315.8 12680.2 13364.6 13938.2 14182.7 14322.8 12318.3 12772.2 12857.9 12965.9 13090.3 12977.9 12989.4 13288.7 13449.4 13784.6 12258.3 12570.6 12590.6 12632.6 12703.0 10406.6 10535.9 10866.8 11178.7 11187.8 9810.8 10333.8 10686.9 10870.6 11010.5 06:06:53 INFO - PROCESS | 12977 | -------- Summary: end -------- 06:06:53 INFO - PROCESS | 12977 | 06:06:53 INFO - TEST-INFO | 12977: exit 0 06:06:53 INFO - TEST-OK | dromaeo_css | took 1110727ms 06:06:53 INFO - TEST-START | kraken 06:06:53 INFO - operating with platform_type : linux_ 06:06:53 INFO - Initialising browser for kraken test... 06:06:53 INFO - TEST-INFO | started process 13211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUfPtPS/profile http://localhost:36096/getInfo.html) 06:06:58 INFO - PROCESS | 13211 | __metrics Screen width/height:1600/1200 06:06:58 INFO - PROCESS | 13211 | colorDepth:24 06:06:58 INFO - PROCESS | 13211 | Browser inner width/height: 1024/697 06:06:58 INFO - PROCESS | 13211 | __metrics 06:06:59 ERROR - PROCESS | 13211 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 06:06:59 INFO - TEST-INFO | 13211: exit 0 06:06:59 INFO - Browser initialized. 06:06:59 INFO - Running cycle 1/1 for kraken test... 06:06:59 INFO - TEST-INFO | started process 13328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUfPtPS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:07:11 INFO - PROCESS | 13328 | RSS: Main: 166961152 06:07:11 INFO - PROCESS | 13328 | 06:07:14 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36096/tests/kraken/driver.html?testName=audio-beat-detection) 06:07:15 INFO - PROCESS | 13328 | RSS: Main: 172322816 06:07:15 INFO - PROCESS | 13328 | 06:07:17 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36096/tests/kraken/driver.html?testName=audio-dft) 06:07:18 INFO - PROCESS | 13328 | RSS: Main: 171868160 06:07:18 INFO - PROCESS | 13328 | 06:07:21 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36096/tests/kraken/driver.html?testName=audio-fft) 06:07:22 INFO - PROCESS | 13328 | RSS: Main: 167116800 06:07:22 INFO - PROCESS | 13328 | 06:07:24 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36096/tests/kraken/driver.html?testName=audio-oscillator) 06:07:25 INFO - PROCESS | 13328 | RSS: Main: 167800832 06:07:25 INFO - PROCESS | 13328 | 06:07:27 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:07:27 INFO - PROCESS | 13328 | RSS: Main: 168271872 06:07:27 INFO - PROCESS | 13328 | 06:07:30 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36096/tests/kraken/driver.html?testName=imaging-darkroom) 06:07:31 INFO - PROCESS | 13328 | RSS: Main: 168812544 06:07:31 INFO - PROCESS | 13328 | 06:07:35 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36096/tests/kraken/driver.html?testName=imaging-desaturate) 06:07:35 INFO - PROCESS | 13328 | RSS: Main: 168980480 06:07:35 INFO - PROCESS | 13328 | 06:07:38 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36096/tests/kraken/driver.html?testName=json-parse-financial) 06:07:39 INFO - PROCESS | 13328 | RSS: Main: 168923136 06:07:39 INFO - PROCESS | 13328 | 06:07:40 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:07:41 INFO - PROCESS | 13328 | RSS: Main: 168886272 06:07:41 INFO - PROCESS | 13328 | 06:07:43 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:07:43 INFO - PROCESS | 13328 | RSS: Main: 168828928 06:07:43 INFO - PROCESS | 13328 | 06:07:45 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:46 INFO - PROCESS | 13328 | RSS: Main: 169345024 06:07:46 INFO - PROCESS | 13328 | 06:07:49 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:49 INFO - PROCESS | 13328 | RSS: Main: 169390080 06:07:49 INFO - PROCESS | 13328 | 06:07:52 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:53 INFO - PROCESS | 13328 | RSS: Main: 169066496 06:07:53 INFO - PROCESS | 13328 | 06:07:54 INFO - PROCESS | 13328 | Cycle 1(1): loaded http://localhost:36096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36096/tests/kraken/driver.html?testName=ai-astar) 06:07:55 INFO - PROCESS | 13328 | RSS: Main: 170041344 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | __start_tp_report 06:07:55 INFO - PROCESS | 13328 | _x_x_mozilla_page_load 06:07:55 INFO - PROCESS | 13328 | _x_x_mozilla_page_load_details 06:07:55 INFO - PROCESS | 13328 | |i|pagename|runs| 06:07:55 INFO - PROCESS | 13328 | |0;ai-astar;113;106;110;110;113;110;111;113;111;111 06:07:55 INFO - PROCESS | 13328 | |1;audio-beat-detection;151;126;152;173;125;161;166;128;186;127 06:07:55 INFO - PROCESS | 13328 | |2;audio-dft;163;163;162;160;164;169;167;162;162;163 06:07:55 INFO - PROCESS | 13328 | |3;audio-fft;76;82;75;156;78;76;76;77;158;75 06:07:55 INFO - PROCESS | 13328 | |4;audio-oscillator;85;93;146;90;86;86;151;85;84;149 06:07:55 INFO - PROCESS | 13328 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;117;117 06:07:55 INFO - PROCESS | 13328 | |6;imaging-darkroom;148;147;147;149;147;147;148;146;147;146 06:07:55 INFO - PROCESS | 13328 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;95;96 06:07:55 INFO - PROCESS | 13328 | |8;json-parse-financial;53;54;54;59;54;63;54;54;55;54 06:07:55 INFO - PROCESS | 13328 | |9;json-stringify-tinderbox;62;63;62;63;63;62;62;62;63;63 06:07:55 INFO - PROCESS | 13328 | |10;stanford-crypto-aes;80;80;83;88;82;82;82;88;111;82 06:07:55 INFO - PROCESS | 13328 | |11;stanford-crypto-ccm;143;136;140;122;124;128;125;130;147;128 06:07:55 INFO - PROCESS | 13328 | |12;stanford-crypto-pbkdf2;164;160;170;163;166;160;164;162;161;162 06:07:55 INFO - PROCESS | 13328 | |13;stanford-crypto-sha256-iterative;64;67;65;63;66;62;64;64;62;65 06:07:55 INFO - PROCESS | 13328 | __end_tp_report 06:07:55 INFO - PROCESS | 13328 | __start_cc_report 06:07:55 INFO - PROCESS | 13328 | _x_x_mozilla_cycle_collect,893 06:07:55 INFO - PROCESS | 13328 | __end_cc_report 06:07:55 INFO - PROCESS | 13328 | __startTimestamp1465218475064__endTimestamp 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | ------- Summary: start ------- 06:07:55 INFO - PROCESS | 13328 | Number of tests: 14 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.10 (1.9%) stddev-sans-first:2.07 06:07:55 INFO - PROCESS | 13328 | Values: 113.0 106.0 110.0 110.0 113.0 110.0 111.0 113.0 111.0 111.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:156.50 stddev:22.16 (14.2%) stddev-sans-first:23.49 06:07:55 INFO - PROCESS | 13328 | Values: 151.0 126.0 152.0 173.0 125.0 161.0 166.0 128.0 186.0 127.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.64 (1.6%) stddev-sans-first:2.79 06:07:55 INFO - PROCESS | 13328 | Values: 163.0 163.0 162.0 160.0 164.0 169.0 167.0 162.0 162.0 163.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:33.85 (44.5%) stddev-sans-first:35.34 06:07:55 INFO - PROCESS | 13328 | Values: 76.0 82.0 75.0 156.0 78.0 76.0 76.0 77.0 158.0 75.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#4] audio-oscillator Cycles:10 Average:105.50 Median:85.50 stddev:29.93 (35.0%) stddev-sans-first:30.81 06:07:55 INFO - PROCESS | 13328 | Values: 85.0 93.0 146.0 90.0 86.0 86.0 151.0 85.0 84.0 149.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:07:55 INFO - PROCESS | 13328 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:07:55 INFO - PROCESS | 13328 | Values: 148.0 147.0 147.0 149.0 147.0 147.0 148.0 146.0 147.0 146.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:07:55 INFO - PROCESS | 13328 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:3.13 (5.8%) stddev-sans-first:3.20 06:07:55 INFO - PROCESS | 13328 | Values: 53.0 54.0 54.0 59.0 54.0 63.0 54.0 54.0 55.0 54.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 06:07:55 INFO - PROCESS | 13328 | Values: 62.0 63.0 62.0 63.0 63.0 62.0 62.0 62.0 63.0 63.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:82.00 stddev:9.30 (11.3%) stddev-sans-first:9.62 06:07:55 INFO - PROCESS | 13328 | Values: 80.0 80.0 83.0 88.0 82.0 82.0 82.0 88.0 111.0 82.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:133.00 stddev:8.65 (6.5%) stddev-sans-first:8.27 06:07:55 INFO - PROCESS | 13328 | Values: 143.0 136.0 140.0 122.0 124.0 128.0 125.0 130.0 147.0 128.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.50 stddev:3.05 (1.9%) stddev-sans-first:3.22 06:07:55 INFO - PROCESS | 13328 | Values: 164.0 160.0 170.0 163.0 166.0 160.0 164.0 162.0 161.0 162.0 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - PROCESS | 13328 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:1.62 (2.5%) stddev-sans-first:1.72 06:07:55 INFO - PROCESS | 13328 | Values: 64.0 67.0 65.0 63.0 66.0 62.0 64.0 64.0 62.0 65.0 06:07:55 INFO - PROCESS | 13328 | -------- Summary: end -------- 06:07:55 INFO - PROCESS | 13328 | 06:07:55 INFO - TEST-INFO | 13328: exit 0 06:07:56 INFO - TEST-OK | kraken | took 62267ms 06:07:56 INFO - SUITE-END | took 1172s 06:07:56 INFO - Completed test suite (00:19:33) 06:07:56 INFO - javascript benchmark 06:07:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7139.217910930439, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.0940127363065, 3125.0, 3145.543896135062, 3163.256634690847, 3168.6672899345567, 5345.385280692722, 5357.651752636076, 5389.892202155955, 5416.187571864218, 5453.672779633225, 5174.197999310113, 5296.126139187039, 5329.467053294668, 5349.358077030762, 5461.18082287657, 4817.710937343753, 4837.854864354057, 4890.877728056809, 4904.926426103611, 4983.6013118950395, 658.2460438172703, 4747.359106520627, 4819.42166939966, 4838.975805120969, 4938.876528086791, 4912.042151780404, 4921.63087768417, 4923.433805112404, 4931.728754918496, 4948.05986862495, 4886.218205087204, 4932.0, 4944.98627781304, 4954.801807927679, 4970.577500912391, 4839.806407743686, 4903.607711383081, 4905.3132561441425, 4918.16391213491, 4925.236588328815, 5363.490468405495, 5363.6245462817615, 5394.91907621386, 5425.945740542584, 5430.348358197002, 5492.780288788444, 5773.653580785166, 5814.6511209327155, 5851.093080572518, 5880.882382352329, 5850.561207909382, 5876.147958546029, 5913.733881975321, 5944.4352786485215, 5958.374370691058, 5517.5585953123655, 5518.978988887028, 5524.723763811833, 5525.254090697745, 5528.44715528448, 5699.886002279931, 5891.204687367151, 5915.053591425351, 6048.637081775019, 6061.6666083365835, 5726.255586773693, 5735.369109397963, 5736.741846616912, 5737.082066869364, 5776.884462310731, 5784.334801497797, 5797.797077102281, 5798.0, 5805.82582522525, 5810.244668193108, 5525.613207075467, 5699.686517241508, 5746.712664366765, 5751.741171647286, 5779.075347944308, 5720.1991721159075, 5750.942490575125, 5773.942260577424, 5780.479756821906, 5803.912941305884, 4333.285007973649, 4382.342648602735, 4416.779161041935, 4418.734875907456, 4421.358902959053, 3808.1622043151015, 3840.423936409505, 3885.378339465672, 3902.3366027775346, 3932.2135572885536, 5528.530074943595, 5542.473465020817, 5545.639533430314, 5599.412061733459, 5612.7754889803955, 5835.44563266489, 5861.677607731615, 5868.295804503401, 5876.676782776988, 5881.088431293157, 5337.786488540492, 5509.338879334506, 5553.194786755897, 5584.357798853102, 5592.189132575753, 5012.498750125032, 5027.0, 5034.0, 5044.445111037783, 5067.214581739836, 5721.4278572143285, 6005.069214271794, 6009.188759517409, 6009.549283803733, 6015.218021657157, 5745.913811292834, 5779.566532510163, 5783.884322313446, 5820.243368362086, 5822.854428639318, 5996.790112346047, 6005.819825405245, 6018.0, 6031.185789918305, 6031.638101713911, 5545.140503221845, 5663.688497132697, 5695.658260504383, 5715.599908006399, 5721.713914304185, 5781.161731548817, 5808.796692115756, 5816.738246778989, 5852.590318677651, 5906.675132867734, 5635.746391412315, 5636.85907852307, 5643.3510146332055, 5678.346990096192, 5685.744141513559, 5463.945360546344, 5558.0, 5579.8884022320135, 5683.943160568341, 5716.485516303553, 5531.170324451204, 5542.750576223999, 5546.889062218653, 5547.472990065938, 5573.108302671553, 5596.1605759136455, 5624.072028115315, 5633.295838020247, 5636.689982051026, 5651.2935883014625, 5392.784288628411, 5524.364698059614, 5543.1408131739645, 5627.859303517281, 5653.632513886584], "value": 5301.502804212476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.2836840475784, 600.0489224579045, 615.1971676961565, 625.5371025441173, 636.1348565950304, 39002.60997390025, 43119.137617247674, 43383.13233735327, 43427.78286108565, 43573.564264357345, 43600.56399436005, 44439.0, 44581.7770911145, 44653.874228803994, 44691.77654111733, 8800.075992020842, 8916.777080572972, 8947.77630559238, 8981.595828187714, 8984.236339911082, 8858.60136293865, 8882.822343553125, 8959.955200223989, 8964.058773828752, 8968.192862642361, 8923.330750193729, 9019.45883247004, 9024.729258122266, 9026.458412495238, 9029.232515236214, 8813.162749538784, 8952.373333866632, 8962.596683149273, 8968.282537396992, 9004.504752238625, 8694.434861733967, 8794.912050879473, 8799.208071273551, 8845.248153906925, 8877.289816814638, 40653.59346406528, 41006.58993410058, 41191.38212926809, 41250.58749412497, 41407.0, 2984.7612191024664, 3183.2360233544014, 3572.589152247499, 3590.0845284452557, 3633.1462106404974, 30327.545086823717, 31047.0, 31113.066608001795, 31129.0, 31183.0, 3957.7427467214825, 4047.655949244318, 4152.709310348277, 4157.792110394498, 4178.498580170369, 326871.0, 330184.0, 330826.0, 330893.3455332732, 333221.0, 35672.821635891654, 35902.64097359045, 36214.45678314827, 36289.63710362915, 36301.0, 33841.32317353639, 35862.282754344764, 36823.26353472916, 37149.0, 37182.81408592994, 14625.414983400546, 14647.194404307653, 14661.780073298909, 14666.63333416673, 14671.0, 12663.050271229511, 12718.300493472947, 12718.427670754838, 12721.491140354283, 12760.361981900867, 8274.586270686563, 8313.12712165226, 8396.244338009608, 8434.15658434164, 8473.533955632376, 3285.0, 3296.4396052671104, 3302.752293577991, 3306.487494438366, 3331.1672081979505, 979.4906648542718, 1038.383274149155, 1132.5130194016488, 1151.45305979659, 1178.3754610056683, 32554.83722581372, 32563.0, 32688.67311326904, 32936.3412731744, 33031.3393732124, 1078.6494389323502, 1104.5968221599219, 1112.1492058575197, 1120.6581992492368, 1258.2387655468492, 16681.332746690237, 17300.134993250285, 17325.0, 17399.73900391495, 17410.39063632767, 541512.0, 550159.0, 556337.0, 556438.0, 556538.0, 60660.0, 60976.69511652413, 60999.99999999911, 61147.6942615293, 61289.38710612926, 1342.2282187741891, 1367.1113776045452, 1388.222595346609, 1398.091240693537, 1405.248192217159, 31345.8432707835, 32059.679403205668, 32301.51547726833, 32391.352172956882, 32798.34403311873, 52406.47593524169, 52805.207921880436, 53198.20202696885, 53337.0, 53448.465515344345, 463207.0, 472686.0, 473438.0, 474983.0, 480484.0, 28484.0, 28810.567841482814, 29203.0, 29222.0, 29295.56056659109, 48583.5141648579, 49232.0, 49849.252261215384, 50556.747216263684, 50569.0, 43313.783431082644, 44008.0, 44127.77936110299, 44410.0, 45124.0, 42021.78989105035, 42331.576684233994, 42457.5754242466, 42505.78747106368, 43634.0, 40318.0, 42233.36649950192, 42298.577014229464, 42368.364474533526, 42561.574384255764, 35848.4622730654, 38015.80992095022, 38900.41649375205, 39023.609763902, 39044.804775975936, 28329.893633910244, 28778.28054298659, 29330.266743330732, 29561.556576651798, 30065.0], "value": 18875.032715898018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4129960510616, 383.1952898912283, 392.8428628548581, 398.5635728876879, 411.9938200926987, 17755.556111097212, 19432.417027489162, 19637.0, 20114.396568102962, 20224.39326820196, 17969.19138638761, 18499.0, 18542.072896355163, 18587.628247435045, 19147.904260478714, 5643.379228284885, 5774.191613174159, 5850.034744267191, 5885.087811389241, 5894.4989675877605, 5704.629199102045, 5758.165066065418, 5786.103154011135, 5804.2744656917885, 5809.9709501452435, 5607.0, 5700.771720189196, 5700.800471983482, 5728.283964504437, 5730.856728581798, 5601.943980560183, 5676.035074037403, 5714.114312281603, 5717.371089180187, 5741.282339707515, 4934.309196712463, 5093.286939828427, 5100.5409513143995, 5122.923156152623, 5151.124308867502, 22096.88951555248, 22180.778192218033, 22289.777102229094, 22427.439314017116, 22861.942425181813, 2407.3018824540864, 2420.0, 2455.889484973163, 2466.580681284186, 2504.1110405805857, 14205.857941420556, 14212.573622791333, 14224.573262802132, 14503.274836258144, 14588.781168282378, 1917.7027560728109, 1930.5173706573357, 1981.4650044487908, 1998.810113039259, 2020.6867935470025, 71257.0, 72524.0, 73282.0, 73561.6321918387, 75343.62328188379, 10279.948600257101, 10345.948270258601, 10412.2515894278, 10535.367877927196, 10640.46797660114, 14414.063085899383, 14526.564203073925, 14538.781918271234, 14629.487967921285, 14639.560813175409, 7575.886361704579, 8203.0, 8326.833463330699, 8418.074011858691, 8446.324294056461, 7981.321587664997, 8101.473404228706, 8131.430799844073, 8238.752837414888, 8288.129746376664, 6633.010096970889, 6649.63427011519, 6750.1224840771365, 6760.9520524318805, 6961.756338528127, 1821.6903126468533, 1856.3688345962437, 1879.8872067675984, 1915.1669023974616, 1925.2395303854898, 850.7617866997251, 962.5187406296851, 967.7725734452398, 1024.5901639344322, 1080.9675709728722, 19341.0, 19481.610367792564, 19589.902050489658, 19596.21615135407, 19864.404067877986, 1015.2081376526321, 1024.5645600619707, 1054.752133248686, 1101.823708206683, 1136.3749937534324, 9233.798621627144, 11278.379689117013, 11310.321380717183, 11314.151438642135, 11355.772884542263, 464460.0, 464831.0, 465091.0, 508238.0, 516981.0, 77057.0, 81255.0, 81282.0, 81367.59316203381, 81681.18318816855, 1062.7874425114853, 1073.414988831089, 1084.7505073833063, 1088.9618863339904, 1095.6767753512734, 17117.65764684724, 17234.65530689404, 17246.0, 17459.47621571355, 17683.911580442014, 29877.551836722032, 36164.27671446609, 37600.2479950394, 37827.62172378351, 38758.6124138755, 50373.49626503688, 50955.49044509508, 51630.48369516407, 51956.0, 54139.18791218213, 8619.612117454604, 8668.219860212612, 8821.60302786389, 8824.955875220583, 8851.734447966572, 9686.418814871131, 13386.799198011842, 13420.664483387993, 13863.306834658428, 13876.236806975714, 11350.772984540428, 11776.528938842694, 11880.702982425508, 11882.584109556125, 12020.939895300467, 11844.348560829238, 11878.287302761863, 11931.522739090338, 12031.819522706992, 12219.144659874079, 11759.647210583697, 11882.108841836724, 12069.0, 12140.696482588006, 12213.38933053326, 8566.742997710078, 8683.131686831266, 8780.165884240987, 8795.252403545514, 8893.866592000995, 11353.148513861659, 12116.636500904988, 12137.69655758613, 12239.20445171061, 12259.203151795105], "value": 9288.00562073482, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.2229018620135, 1516.1964158995731, 1624.5694890853927, 1747.423350294402, 1774.1395423219744, 7399.963000184992, 7945.9602701986405, 7979.441439099265, 8439.620217090238, 8489.0, 8138.552379619118, 8285.254327110559, 8305.626246818907, 8394.706185283516, 8414.705485308, 2236.3738153317017, 2284.4403121235237, 2295.472041430472, 2297.3337732057685, 2300.87345196015, 2118.353902059871, 2138.7112739780086, 2168.04605973372, 2172.3700126963163, 2178.0525471419905, 2094.9266775662854, 2115.122224276931, 2115.524007098398, 2127.9042443090098, 2153.3001774423374, 2115.185653523389, 2118.8410869184795, 2127.0853532980736, 2128.265748316828, 2128.425325162213, 2199.1533259695134, 2226.4100013496436, 2231.665250212465, 2234.7318321801326, 2245.8091062259728, 8250.257476827115, 8319.542425166614, 8343.916560834376, 8353.624086916103, 8362.16378362165, 4941.604671626261, 5034.0, 5035.496450354972, 5050.924236136461, 5053.115704751691, 3070.8003979741247, 3183.315587148751, 3209.5667084943466, 3223.7904536205306, 3231.709146176832, 1080.0837738107064, 1107.9224454288203, 1129.1982692288484, 1135.1656532448644, 1142.4744617475972, 10946.233763636548, 11119.72200694981, 11160.720981975435, 11408.0, 11569.016633586156, 4288.678349123828, 4298.570142985739, 4336.371226172188, 4395.055063161436, 4398.098389830077, 9071.682491112912, 9121.17909388145, 9132.269418446509, 9135.908640913638, 9160.496172710566, 4967.130752118364, 4981.651284410129, 5024.824131155392, 5033.471485494044, 5034.370703662043, 4023.657989070903, 4462.241418958784, 4585.12882552314, 4602.884927876763, 4635.860924172281, 3495.7727747696827, 3504.7021003214504, 3563.4120370139153, 3590.6588874056924, 3612.7832330060282, 1034.3225187502198, 1062.4315990944808, 1067.6796960911695, 1081.3619964221148, 1091.5524634899812, 914.8947870994788, 954.1031430455349, 979.6413617512197, 983.8130755156641, 992.9652462163934, 5473.8357849264585, 5567.55459563242, 5571.0807716727095, 5586.245856809279, 5781.046127389018, 394.0955507111187, 395.40096753418595, 395.52141908290713, 403.9616236457532, 413.97309174903535, 3838.712096592711, 3851.422286657024, 3870.9225815484097, 3877.592852750477, 3932.606739326102, 9976.800463990825, 10269.486525673687, 10276.280660353703, 10315.845262320921, 10330.483475826179, 9846.310758246997, 10116.08955194036, 10125.746856328651, 10138.341007834468, 10166.593336266615, 7752.6898924043535, 7804.3756499479905, 7834.843303134019, 7845.6077196141105, 7862.253085956825, 5394.27177331071, 5398.892022159456, 5482.643628164156, 5512.862178445571, 5589.944100559105, 9291.907080929104, 9566.0, 9577.664781732607, 9605.663801767185, 9650.565724542272, 9541.522923853918, 9599.808003840024, 9853.359531630422, 9981.45102019396, 9995.950020249853, 7226.927730722836, 7868.291853733192, 7982.161873003483, 8129.430939834155, 8190.877136842833, 8287.875681864656, 8309.916900830915, 8338.374621903502, 8345.457545259538, 8368.0, 7391.260873912781, 7581.090269167735, 7631.923680763121, 7650.4644674872225, 7715.768526944201, 7154.534955227893, 7425.480216384801, 7440.181580026301, 7452.217517160837, 7523.172451030273, 6890.20762612306, 6897.931020689729, 6947.23580406165, 6964.129483814523, 7000.439964802906, 4666.160091183619, 4704.482506924167, 4767.570918617341, 4801.327814105958, 4824.517548245148, 4949.950500494949, 4975.701457912537, 4986.376702912136, 4991.0, 5062.038212739568], "value": 4299.806452615785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.75318757744117, 326.59828411054394, 326.7696274126741, 334.56506541496066, 337.3489165909796, 5625.943740562599, 5653.2016651757385, 5671.2986104168795, 5699.800506982257, 5716.514096301809, 5562.471565201299, 5563.610547261683, 5567.916481252784, 5577.21918931349, 5579.358373787016, 4136.793160341986, 4206.978965105171, 4245.0, 4322.610965013148, 4330.285502892035, 4245.639120674731, 4290.97854510727, 4296.3770253313405, 4299.398084268205, 4305.24658184818, 4295.119500502406, 4296.205202037633, 4315.352697095445, 4317.654587632997, 4332.566743325658, 4069.9186016279655, 4282.978585107086, 4304.289792184286, 4305.849295274682, 4339.761313127777, 3749.325121478133, 3749.531308586427, 3767.8492860285555, 3777.376732839078, 3782.3569993101237, 5341.545968592674, 5364.785408583652, 5421.268128802601, 5422.457754224585, 5439.4832490913695, 4814.7833347499445, 4853.294517611643, 4863.19757240055, 4890.0, 4923.01539692063, 5785.0, 5814.557885688021, 5815.912761308584, 5842.707864606753, 5863.5016023638045, 4082.5713300103657, 4128.2156390285745, 4135.560019588427, 4161.607075931352, 4167.062316023063, 5923.956235098884, 6055.818325450244, 6073.635581865102, 6094.360092190301, 6132.356102609207, 4147.605977432139, 4166.0, 4185.330347144442, 4186.162767446523, 4196.594140962811, 4229.133027729308, 4244.893877653083, 4264.147170565837, 4267.25323068468, 4268.274393353137, 4674.789634466457, 4935.580475659537, 4944.381952255968, 4957.702537847741, 4964.255361695775, 5827.504662103684, 5883.588148829626, 5894.17481552583, 5957.791477298274, 5973.6260660047565, 1441.22894251577, 1466.9266536673124, 1472.8085348904788, 1478.8538882366252, 1481.1853480585635, 912.4616476279027, 915.404986758599, 925.319889880937, 961.8941916389192, 969.0116081596873, 5628.971855140698, 5683.54531637468, 5704.714764261853, 5712.65724056558, 5718.51392631631, 6015.669138197353, 6035.155078289043, 6046.758129674852, 6061.363556826558, 6100.359462256488, 5409.486098820685, 5708.71456427177, 5766.423357664284, 5799.88400231993, 5800.955827950925, 3224.290656055664, 3226.225705830631, 3247.2044349134612, 3250.333681595267, 3257.397381484433, 6149.016157414792, 6280.514314555466, 6298.1812364392335, 6308.085327627468, 6309.825942727011, 6124.908126378108, 6180.196574445294, 6195.380461953859, 6223.719932603044, 6277.780277690259, 6033.607815491979, 6233.532485063638, 6256.7810126645345, 6272.466840318532, 6297.937020629826, 6042.277950784005, 6058.515318774399, 6064.696765161812, 6078.179445774764, 6083.422074902877, 5939.0, 5980.192673988956, 6004.759809607567, 6005.699715014319, 6043.184170137151, 6003.099535069775, 6190.380961903774, 6240.0, 6256.90504161779, 6293.150424692791, 4232.492100947906, 4246.745195288293, 4253.936190957076, 4268.87193384199, 4292.635126014324, 5811.506021988178, 5924.6149000314845, 6058.5758996871555, 6106.236720409949, 6123.755049797958, 5801.593888427769, 5820.1560773688425, 5866.384029676993, 5872.500837428866, 5877.23595932526, 5829.912551311649, 5853.268341457318, 5880.617759845596, 5883.470487656132, 5885.735141918538, 5587.608867379245, 5657.179708942263, 5776.133579963039, 5776.942230577641, 5781.739821707949, 5911.881762364643, 5919.526437884872, 5924.526037917042, 5937.465628093492, 5962.896864079986, 5485.396606373216, 5763.164341170423, 5771.913421298768, 5797.362290148165, 5864.413558644102], "value": 4445.237183484229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.3301029073833, 766.7004427495398, 769.4306213402084, 819.7376839411388, 828.8300898315846, 14563.199024053685, 15692.921535392321, 16013.19934003301, 16100.275487603056, 16139.579063140505, 14104.153750774934, 14485.348159332829, 14488.782668259984, 14509.49216777413, 14699.044562103456, 808.3250485844312, 814.543855440955, 817.8650522663753, 824.4764574495209, 824.9010118785754, 787.3937068457284, 809.8258874342015, 813.3168138763438, 815.7878951472601, 825.8059356051323, 859.3640705877636, 861.1001503428931, 864.2999170671776, 864.723288547665, 865.8571335729597, 852.4970267542149, 857.536930057765, 859.2438653984516, 861.1431625532573, 861.1732736572898, 620.1318154583574, 622.4304761143549, 623.0840664223584, 623.1742940603718, 625.4121126141413, 15134.394624215018, 15151.090934543963, 15204.239788010666, 15206.315715792816, 15266.160361180131, 14201.928990355085, 14275.857241427557, 14332.211728354936, 14332.211728354936, 14555.199464029474, 12052.337121458317, 12088.576899808464, 12199.268043917393, 12255.1421400502, 12641.304728239944, 3816.561095474028, 3877.0, 3887.8833634990997, 4010.7794071326066, 4050.25070361984, 78358.6082069586, 78789.60605196937, 78792.0, 79126.6043669778, 79375.0, 11013.809530913437, 11125.94437027826, 11202.831957520644, 11324.886751132548, 11478.253913495597, 20939.0, 21084.0, 21094.78905210959, 21143.577128457346, 21197.470063248235, 8482.151784821468, 8536.061033286334, 8624.0, 8624.137586241326, 8929.0, 4924.261360795909, 5034.34553508049, 5063.088644044034, 5177.068127737043, 5177.8187763428095, 3534.3638145134123, 3631.5642122944887, 3636.2182130841998, 3651.507046548682, 3659.0486473516544, 607.5018484842387, 608.5375114912698, 610.1793088296234, 617.5831313863214, 620.2216218645661, 647.3752828520501, 728.3845150847526, 746.8892064551192, 774.9883751743729, 775.5656832174001, 9623.0, 9667.903320966841, 9827.557759900821, 9902.653407130716, 10013.79972400548, 709.982250443743, 722.288545782404, 735.6395366270596, 750.7560042986051, 759.9012128423269, 4488.192125417456, 4523.5024147343765, 4638.536146385334, 4675.18184317743, 4834.613230941516, 68589.65705171542, 115083.42458287823, 115154.0, 118368.40815795866, 119053.40473297577, 62388.37611623917, 78788.0, 98466.0, 99262.0, 99415.50292248493, 87472.0, 88037.0, 88339.55830220936, 88492.5575372119, 89365.10634893698, 8969.730908072768, 9053.230475409664, 9142.862857057016, 9144.451332920045, 9290.473546442474, 42954.0, 51021.0, 51552.48447515477, 53202.4679753213, 53835.73082134564, 44557.55442445534, 50948.74525627348, 73609.6319518399, 74420.0, 74492.62753686414, 11842.46708898119, 11997.580084696994, 12034.097442691658, 12105.273683579013, 12315.75368492643, 12680.23918564889, 13364.599062028155, 13938.233397163254, 14182.716345673236, 14322.785158222843, 12318.260904345769, 12772.233665980071, 12857.935710321763, 12965.935170324088, 13090.280034597808, 12977.935110324388, 12989.350532473527, 13288.667783305495, 13449.394777235244, 13784.586462406143, 12258.325792081165, 12570.622881313575, 12590.559330423392, 12632.557860474839, 12703.0, 10406.58373665045, 10535.947320263349, 10866.836997445203, 11178.720531986766, 11187.832182517432, 9810.803783924424, 10333.793324133325, 10686.89313106859, 10870.61952831647, 11010.50452729645], "value": 7452.588594176426, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 110.0, 110.0, 113.0, 110.0, 111.0, 113.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 152.0, 173.0, 125.0, 161.0, 166.0, 128.0, 186.0, 127.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 160.0, 164.0, 169.0, 167.0, 162.0, 162.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 75.0, 156.0, 78.0, 76.0, 76.0, 77.0, 158.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 146.0, 90.0, 86.0, 86.0, 151.0, 85.0, 84.0, 149.0], "value": 105.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 149.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 59.0, 54.0, 63.0, 54.0, 54.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 83.0, 88.0, 82.0, 82.0, 82.0, 88.0, 111.0, 82.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 140.0, 122.0, 124.0, 128.0, 125.0, 130.0, 147.0, 128.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 170.0, 163.0, 166.0, 160.0, 164.0, 162.0, 161.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 63.0, 66.0, 62.0, 64.0, 64.0, 62.0, 65.0], "value": 64.2, "unit": "score"}]}]} 06:07:56 INFO - Return code: 0 06:07:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:56 ERROR - # TBPL SUCCESS # 06:07:56 INFO - Running post-action listener: _resource_record_post_action 06:07:56 INFO - ##### 06:07:56 INFO - ##### Finished run-tests step (success) 06:07:56 INFO - ##### 06:07:56 INFO - Running post-run listener: _resource_record_post_run 06:07:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548622336; Read time: 24; Write time: 373172 06:07:56 INFO - TinderboxPrint: CPU usage
13.4% 06:07:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 06:07:56 INFO - TinderboxPrint: I/O write bytes / time
548,622,336 / 373,172 06:07:56 INFO - TinderboxPrint: CPU idle
8,224.9 (86.5%) 06:07:56 INFO - TinderboxPrint: CPU user
1,223.8 (12.9%) 06:07:56 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 154062848; Read time: 0; Write time: 128652 06:07:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291590144; Read time: 24; Write time: 166468 06:07:57 INFO - Running post-run listener: _upload_blobber_files 06:07:57 INFO - Blob upload gear active. 06:07:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:57 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 06:07:57 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:07:57 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:07:57 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:07:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:07:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:58 INFO - (blobuploader) - INFO - Done attempting. 06:07:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:08:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:01 INFO - (blobuploader) - INFO - Done attempting. 06:08:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:08:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:08:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:08:02 INFO - (blobuploader) - INFO - Done attempting. 06:08:02 INFO - (blobuploader) - INFO - Iteration through files over. 06:08:02 INFO - Return code: 0 06:08:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:08:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:08:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a23cd928dc80cffa847e88a7699ad74521a865970cafc919a17851246cc719429a1fb2b0e1e684321b0af6a5e9ea75699c674fb092268d05d25924ade42a951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4a1dfbe6c6894fb1d788228b01a3885abe37ffa2aaaaa7df5c947e82c32ee4c809746ff275fee6ca47261bc3dcaafc9f0a5eda92d7094d7876a5c8e7aa7a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/760c00367193a1af115b9bc465b0c338f22d632717cdef88cfcfc92325bfc67ef743a319c60d044de78a407ff4ee246742c9a2991f0d4be04ca529dc50af078d"} 06:08:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:02 INFO - Contents: 06:08:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a23cd928dc80cffa847e88a7699ad74521a865970cafc919a17851246cc719429a1fb2b0e1e684321b0af6a5e9ea75699c674fb092268d05d25924ade42a951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4a1dfbe6c6894fb1d788228b01a3885abe37ffa2aaaaa7df5c947e82c32ee4c809746ff275fee6ca47261bc3dcaafc9f0a5eda92d7094d7876a5c8e7aa7a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/760c00367193a1af115b9bc465b0c338f22d632717cdef88cfcfc92325bfc67ef743a319c60d044de78a407ff4ee246742c9a2991f0d4be04ca529dc50af078d"} 06:08:02 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:02 INFO - Copying logs to upload dir... 06:08:02 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.557737 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-06 06:08:02.461171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:08:02.464897) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290 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/Firefox/sha512/5a23cd928dc80cffa847e88a7699ad74521a865970cafc919a17851246cc719429a1fb2b0e1e684321b0af6a5e9ea75699c674fb092268d05d25924ade42a951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4a1dfbe6c6894fb1d788228b01a3885abe37ffa2aaaaa7df5c947e82c32ee4c809746ff275fee6ca47261bc3dcaafc9f0a5eda92d7094d7876a5c8e7aa7a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/760c00367193a1af115b9bc465b0c338f22d632717cdef88cfcfc92325bfc67ef743a319c60d044de78a407ff4ee246742c9a2991f0d4be04ca529dc50af078d"} build_url:https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/aI3iU6z_ROqsEYy4o19Yuw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a23cd928dc80cffa847e88a7699ad74521a865970cafc919a17851246cc719429a1fb2b0e1e684321b0af6a5e9ea75699c674fb092268d05d25924ade42a951", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4a1dfbe6c6894fb1d788228b01a3885abe37ffa2aaaaa7df5c947e82c32ee4c809746ff275fee6ca47261bc3dcaafc9f0a5eda92d7094d7876a5c8e7aa7a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/760c00367193a1af115b9bc465b0c338f22d632717cdef88cfcfc92325bfc67ef743a319c60d044de78a407ff4ee246742c9a2991f0d4be04ca529dc50af078d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:08:02.489467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:08:02.489816) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465215878.968610-192586290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:08:02.576221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:08:02.576583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:08:02.576850) ========= ========= Total master_lag: 0.20 =========