builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1466074946.05 results: success (0) buildid: 20160616013125 builduid: 4ff50bfc5fa6492196f22a26fd4df1a4 revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.047670) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.048122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.048409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.073873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.074214) ========= 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=df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 04:02:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.0M=0s 2016-06-16 04:02:26 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.183579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.183895) ========= 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=df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023086 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.241980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.242314) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6b40db1565705c392042da04396d1ca83c0d017d --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 6b40db1565705c392042da04396d1ca83c0d017d --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=df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 04:02:26,789 truncating revision to first 12 chars 2016-06-16 04:02:26,789 Setting DEBUG logging. 2016-06-16 04:02:26,789 attempt 1/10 2016-06-16 04:02:26,789 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6b40db156570?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 04:02:27,098 unpacking tar archive at: mozilla-central-6b40db156570/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.908941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.909255) ========= script_repo_revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.909675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.909949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.917200) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-16 04:02:26.917541) ========= /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=df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:02:27 INFO - MultiFileLogger online at 20160616 04:02:27 in /builds/slave/test 04:02:27 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 04:02:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:02:27 INFO - {'append_to_log': False, 04:02:27 INFO - 'base_work_dir': '/builds/slave/test', 04:02:27 INFO - 'blob_upload_branch': 'Firefox', 04:02:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:02:27 INFO - 'branch': 'Firefox', 04:02:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:02:27 INFO - 'config_files': ('talos/linux_config.py',), 04:02:27 INFO - 'default_actions': ('clobber', 04:02:27 INFO - 'read-buildbot-config', 04:02:27 INFO - 'download-and-extract', 04:02:27 INFO - 'populate-webroot', 04:02:27 INFO - 'create-virtualenv', 04:02:27 INFO - 'install', 04:02:27 INFO - 'run-tests'), 04:02:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:02:27 INFO - 'download_minidump_stackwalk': True, 04:02:27 INFO - 'download_symbols': 'ondemand', 04:02:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:02:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:02:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:02:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:02:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:02:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:02:27 INFO - 'installer_path': 'installer.exe', 04:02:27 INFO - 'log_level': 'info', 04:02:27 INFO - 'log_name': 'talos', 04:02:27 INFO - 'log_to_console': True, 04:02:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:02:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:02:27 INFO - 'opt_config_files': (), 04:02:27 INFO - 'pip_index': False, 04:02:27 INFO - 'sps_profile': False, 04:02:27 INFO - 'sps_profile_interval': 0, 04:02:27 INFO - 'suite': 'dromaeojs-e10s', 04:02:27 INFO - 'system_bits': '32', 04:02:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:02:27 INFO - 'title': 'talos-linux64-ix-021', 04:02:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:02:27 INFO - 'use_talos_json': True, 04:02:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:02:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:02:27 INFO - 'work_dir': 'build'} 04:02:27 INFO - ##### 04:02:27 INFO - ##### Running clobber step. 04:02:27 INFO - ##### 04:02:27 INFO - Running pre-action listener: _resource_record_pre_action 04:02:27 INFO - Running main action method: clobber 04:02:27 INFO - rmtree: /builds/slave/test/build 04:02:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - ##### 04:02:28 INFO - ##### Finished clobber step (success) 04:02:28 INFO - ##### 04:02:28 INFO - ##### 04:02:28 INFO - ##### Running read-buildbot-config step. 04:02:28 INFO - ##### 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running main action method: read_buildbot_config 04:02:28 INFO - Using buildbot properties: 04:02:28 INFO - { 04:02:28 INFO - "project": "", 04:02:28 INFO - "product": "firefox", 04:02:28 INFO - "script_repo_revision": "production", 04:02:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:02:28 INFO - "repository": "", 04:02:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:02:28 INFO - "buildid": "20160616013125", 04:02:28 INFO - "pgo_build": "True", 04:02:28 INFO - "basedir": "/builds/slave/test", 04:02:28 INFO - "buildnumber": 251, 04:02:28 INFO - "slavename": "talos-linux64-ix-021", 04:02:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:02:28 INFO - "platform": "ubuntu64_hw", 04:02:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:02:28 INFO - "branch": "mozilla-central", 04:02:28 INFO - "repo_path": "mozilla-central", 04:02:28 INFO - "revision": "6b40db1565705c392042da04396d1ca83c0d017d", 04:02:28 INFO - "stage_platform": "linux64-pgo", 04:02:28 INFO - "builduid": "4ff50bfc5fa6492196f22a26fd4df1a4", 04:02:28 INFO - "slavebuilddir": "test" 04:02:28 INFO - } 04:02:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - ##### 04:02:28 INFO - ##### Finished read-buildbot-config step (success) 04:02:28 INFO - ##### 04:02:28 INFO - ##### 04:02:28 INFO - ##### Running download-and-extract step. 04:02:28 INFO - ##### 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running main action method: download_and_extract 04:02:28 INFO - mkdir: /builds/slave/test/build/tests 04:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:28 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:02:32 INFO - Downloaded 1361 bytes. 04:02:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:32 INFO - Using the following test package requirements: 04:02:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:02:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:02:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'jsshell-linux-x86_64.zip'], 04:02:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:02:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:02:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:02:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:02:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:02:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:02: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')]} 04:02:32 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:34 INFO - Downloaded 24220364 bytes. 04:02:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:02:36 INFO - Return code: 0 04:02:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:36 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:38 INFO - Downloaded 24220364 bytes. 04:02:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:02:39 INFO - Return code: 0 04:02:39 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')]} 04:02:39 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:02:40 INFO - Downloaded 14405384 bytes. 04:02:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:02:40 INFO - Return code: 0 04:02:40 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')]} 04:02:40 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:02:43 INFO - Downloaded 59401722 bytes. 04:02:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:43 INFO - mkdir: /builds/slave/test/properties 04:02:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:02:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:02:43 INFO - Contents: 04:02:43 INFO - build_url:https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:44 INFO - Running post-action listener: _resource_record_post_action 04:02:44 INFO - Running post-action listener: set_extra_try_arguments 04:02:44 INFO - ##### 04:02:44 INFO - ##### Finished download-and-extract step (success) 04:02:44 INFO - ##### 04:02:44 INFO - ##### 04:02:44 INFO - ##### Running populate-webroot step. 04:02:44 INFO - ##### 04:02:44 INFO - Running pre-action listener: _resource_record_pre_action 04:02:44 INFO - Running main action method: populate_webroot 04:02:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:02:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:02:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:02:44 INFO - '--tppagecycles', 04:02:44 INFO - '7'], 04:02:44 INFO - 'tests': ['tsvgm']}}, 04:02:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:02:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:02:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:02:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:02:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['damp', 'tps']}, 04:02:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'tests': ['damp', 'tps']}, 04:02:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['dromaeo_dom']}, 04:02:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:02:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['basic_compositor_video']}, 04:02:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:02:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['a11yr', 04:02:44 INFO - 'ts_paint', 04:02:44 INFO - 'tpaint', 04:02:44 INFO - 'sessionrestore', 04:02:44 INFO - 'sessionrestore_no_auto_restore', 04:02:44 INFO - 'tabpaint']}, 04:02:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:02:44 INFO - 'ts_paint', 04:02:44 INFO - 'tpaint', 04:02:44 INFO - 'sessionrestore', 04:02:44 INFO - 'sessionrestore_no_auto_restore', 04:02:44 INFO - 'tabpaint']}, 04:02:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:02:44 INFO - 'ts_paint', 04:02:44 INFO - 'tpaint', 04:02:44 INFO - 'sessionrestore', 04:02:44 INFO - 'sessionrestore_no_auto_restore', 04:02:44 INFO - 'tabpaint']}, 04:02:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:02:44 INFO - 'ts_paint', 04:02:44 INFO - 'tpaint', 04:02:44 INFO - 'sessionrestore', 04:02:44 INFO - 'sessionrestore_no_auto_restore', 04:02:44 INFO - 'tabpaint']}, 04:02:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['a11yr', 04:02:44 INFO - 'ts_paint', 04:02:44 INFO - 'tpaint', 04:02:44 INFO - 'sessionrestore', 04:02:44 INFO - 'sessionrestore_no_auto_restore', 04:02:44 INFO - 'tabpaint']}, 04:02:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['a11yr', 04:02:44 INFO - 'ts_paint', 04:02:44 INFO - 'tpaint', 04:02:44 INFO - 'sessionrestore', 04:02:44 INFO - 'sessionrestore_no_auto_restore', 04:02:44 INFO - 'tabpaint']}, 04:02:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['tsvgx', 04:02:44 INFO - 'tsvgr_opacity', 04:02:44 INFO - 'tart', 04:02:44 INFO - 'tscrollx', 04:02:44 INFO - 'cart']}, 04:02:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:02:44 INFO - 'tsvgr_opacity', 04:02:44 INFO - 'tart', 04:02:44 INFO - 'tscrollx', 04:02:44 INFO - 'cart']}, 04:02:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'talos_options': ['--disable-e10s'], 04:02:44 INFO - 'tests': ['tp5o']}, 04:02:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'tests': ['tp5o']}, 04:02:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'talos_options': ['--disable-e10s', 04:02:44 INFO - '--xperf_path', 04:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:44 INFO - 'tests': ['tp5n']}, 04:02:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:44 INFO - 'talos_options': ['--xperf_path', 04:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:44 INFO - 'tests': ['tp5n']}}, 04:02:44 INFO - 'talos.zip': {'path': '', 04:02:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:02:44 INFO - Running post-action listener: _resource_record_post_action 04:02:44 INFO - ##### 04:02:44 INFO - ##### Finished populate-webroot step (success) 04:02:44 INFO - ##### 04:02:44 INFO - ##### 04:02:44 INFO - ##### Running create-virtualenv step. 04:02:44 INFO - ##### 04:02:44 INFO - Running pre-action listener: _resource_record_pre_action 04:02:44 INFO - Running main action method: create_virtualenv 04:02:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:02:44 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 04:02:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:02:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:02:44 INFO - Using real prefix '/usr' 04:02:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:02:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:47 INFO - Installing pip.................done. 04:02:47 INFO - Return code: 0 04:02:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:02: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', 'pip>=1.5'] in /builds/slave/test/build 04:02: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 pip>=1.5 04:02:47 INFO - Using env: {'DISPLAY': ':0', 04:02:47 INFO - 'HOME': '/home/cltbld', 04:02:47 INFO - 'LANG': 'en_US.UTF-8', 04:02:47 INFO - 'LANGUAGE': 'en_US:en', 04:02:47 INFO - 'LOGNAME': 'cltbld', 04:02:47 INFO - 'MAIL': '/var/mail/cltbld', 04:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:47 INFO - 'MOZ_NO_REMOTE': '1', 04:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:47 INFO - 'NO_EM_RESTART': '1', 04:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:47 INFO - 'PWD': '/builds/slave/test', 04:02:47 INFO - 'SHELL': '/bin/bash', 04:02:47 INFO - 'SHLVL': '1', 04:02:47 INFO - 'TERM': 'linux', 04:02:47 INFO - 'TMOUT': '86400', 04:02:47 INFO - 'USER': 'cltbld', 04:02:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:47 INFO - '_': '/tools/buildbot/bin/python'} 04:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:47 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 04:02:47 INFO - Cleaning up... 04:02:47 INFO - Return code: 0 04:02:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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', '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 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:02: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 psutil>=3.1.1 04:02:47 INFO - Using env: {'DISPLAY': ':0', 04:02:47 INFO - 'HOME': '/home/cltbld', 04:02:47 INFO - 'LANG': 'en_US.UTF-8', 04:02:47 INFO - 'LANGUAGE': 'en_US:en', 04:02:47 INFO - 'LOGNAME': 'cltbld', 04:02:47 INFO - 'MAIL': '/var/mail/cltbld', 04:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:47 INFO - 'MOZ_NO_REMOTE': '1', 04:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:47 INFO - 'NO_EM_RESTART': '1', 04:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:47 INFO - 'PWD': '/builds/slave/test', 04:02:47 INFO - 'SHELL': '/bin/bash', 04:02:47 INFO - 'SHLVL': '1', 04:02:47 INFO - 'TERM': 'linux', 04:02:47 INFO - 'TMOUT': '86400', 04:02:47 INFO - 'USER': 'cltbld', 04:02:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:47 INFO - '_': '/tools/buildbot/bin/python'} 04:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:47 INFO - Downloading/unpacking psutil>=3.1.1 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:49 INFO - Installing collected packages: psutil 04:02:49 INFO - Running setup.py install for psutil 04:02:49 INFO - building 'psutil._psutil_linux' extension 04:02:49 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 04:02:49 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 04:02:49 INFO - building 'psutil._psutil_posix' extension 04:02:49 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 04:02:49 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 04:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:49 INFO - Successfully installed psutil 04:02:49 INFO - Cleaning up... 04:02:50 INFO - Return code: 0 04:02:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:02: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:02: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 mozsystemmonitor==0.3 04:02:50 INFO - Using env: {'DISPLAY': ':0', 04:02:50 INFO - 'HOME': '/home/cltbld', 04:02:50 INFO - 'LANG': 'en_US.UTF-8', 04:02:50 INFO - 'LANGUAGE': 'en_US:en', 04:02:50 INFO - 'LOGNAME': 'cltbld', 04:02:50 INFO - 'MAIL': '/var/mail/cltbld', 04:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:50 INFO - 'MOZ_NO_REMOTE': '1', 04:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:50 INFO - 'NO_EM_RESTART': '1', 04:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:50 INFO - 'PWD': '/builds/slave/test', 04:02:50 INFO - 'SHELL': '/bin/bash', 04:02:50 INFO - 'SHLVL': '1', 04:02:50 INFO - 'TERM': 'linux', 04:02:50 INFO - 'TMOUT': '86400', 04:02:50 INFO - 'USER': 'cltbld', 04:02:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:50 INFO - '_': '/tools/buildbot/bin/python'} 04:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:02:52 INFO - Installing collected packages: mozsystemmonitor 04:02:52 INFO - Running setup.py install for mozsystemmonitor 04:02:52 INFO - Successfully installed mozsystemmonitor 04:02:52 INFO - Cleaning up... 04:02:52 INFO - Return code: 0 04:02:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:02:52 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')]} 04:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 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')]} 04:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:52 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 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:02:52 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 04:02:52 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 04:02:52 INFO - Using env: {'DISPLAY': ':0', 04:02:52 INFO - 'HOME': '/home/cltbld', 04:02:52 INFO - 'LANG': 'en_US.UTF-8', 04:02:52 INFO - 'LANGUAGE': 'en_US:en', 04:02:52 INFO - 'LOGNAME': 'cltbld', 04:02:52 INFO - 'MAIL': '/var/mail/cltbld', 04:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:52 INFO - 'MOZ_NO_REMOTE': '1', 04:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:52 INFO - 'NO_EM_RESTART': '1', 04:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:52 INFO - 'PWD': '/builds/slave/test', 04:02:52 INFO - 'SHELL': '/bin/bash', 04:02:52 INFO - 'SHLVL': '1', 04:02:52 INFO - 'TERM': 'linux', 04:02:52 INFO - 'TMOUT': '86400', 04:02:52 INFO - 'USER': 'cltbld', 04:02:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:52 INFO - '_': '/tools/buildbot/bin/python'} 04:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:52 INFO - Downloading/unpacking jsonschema==2.5.1 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:02:54 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 04:02:54 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 04:02:54 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 04:02:54 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 04:02:54 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 04:02:54 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 04:02:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:54 INFO - warning: no files found matching '*.txt' 04:02:54 INFO - no previously-included directories found matching 'build' 04:02:54 INFO - no previously-included directories found matching 'dist' 04:02:54 INFO - no previously-included directories found matching '.git*' 04:02:54 INFO - Installing collected packages: jsonschema, functools32 04:02:54 INFO - Running setup.py install for functools32 04:02:54 INFO - warning: no files found matching '*.txt' 04:02:54 INFO - no previously-included directories found matching 'build' 04:02:54 INFO - no previously-included directories found matching 'dist' 04:02:54 INFO - no previously-included directories found matching '.git*' 04:02:54 INFO - Successfully installed jsonschema functools32 04:02:54 INFO - Cleaning up... 04:02:54 INFO - Return code: 0 04:02:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:54 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 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:02:54 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 04:02:54 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 04:02:54 INFO - Using env: {'DISPLAY': ':0', 04:02:54 INFO - 'HOME': '/home/cltbld', 04:02:54 INFO - 'LANG': 'en_US.UTF-8', 04:02:54 INFO - 'LANGUAGE': 'en_US:en', 04:02:54 INFO - 'LOGNAME': 'cltbld', 04:02:54 INFO - 'MAIL': '/var/mail/cltbld', 04:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:54 INFO - 'MOZ_NO_REMOTE': '1', 04:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:54 INFO - 'NO_EM_RESTART': '1', 04:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:54 INFO - 'PWD': '/builds/slave/test', 04:02:54 INFO - 'SHELL': '/bin/bash', 04:02:54 INFO - 'SHLVL': '1', 04:02:54 INFO - 'TERM': 'linux', 04:02:54 INFO - 'TMOUT': '86400', 04:02:54 INFO - 'USER': 'cltbld', 04:02:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:54 INFO - '_': '/tools/buildbot/bin/python'} 04:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:55 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 04:02:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 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 04:02:57 INFO - Downloading docopt-0.6.1.tar.gz 04:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:57 INFO - Running setup.py install for blobuploader 04:02:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:57 INFO - Running setup.py install for requests 04:02:58 INFO - Running setup.py install for docopt 04:02:58 INFO - Successfully installed blobuploader requests docopt 04:02:58 INFO - Cleaning up... 04:02:58 INFO - Return code: 0 04:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:58 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 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:02:58 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 04:02:58 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 04:02:58 INFO - Using env: {'DISPLAY': ':0', 04:02:58 INFO - 'HOME': '/home/cltbld', 04:02:58 INFO - 'LANG': 'en_US.UTF-8', 04:02:58 INFO - 'LANGUAGE': 'en_US:en', 04:02:58 INFO - 'LOGNAME': 'cltbld', 04:02:58 INFO - 'MAIL': '/var/mail/cltbld', 04:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:58 INFO - 'MOZ_NO_REMOTE': '1', 04:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:58 INFO - 'NO_EM_RESTART': '1', 04:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:58 INFO - 'PWD': '/builds/slave/test', 04:02:58 INFO - 'SHELL': '/bin/bash', 04:02:58 INFO - 'SHLVL': '1', 04:02:58 INFO - 'TERM': 'linux', 04:02:58 INFO - 'TMOUT': '86400', 04:02:58 INFO - 'USER': 'cltbld', 04:02:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:58 INFO - '_': '/tools/buildbot/bin/python'} 04:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:58 INFO - Running setup.py (path:/tmp/pip-7zyBwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:58 INFO - Running setup.py (path:/tmp/pip-UVOXMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:58 INFO - Running setup.py (path:/tmp/pip-BuHVcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:58 INFO - Running setup.py (path:/tmp/pip-1aI2Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:58 INFO - Running setup.py (path:/tmp/pip-Ula_Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:58 INFO - Running setup.py (path:/tmp/pip-mZrcU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:59 INFO - Running setup.py (path:/tmp/pip-uNBztK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:59 INFO - Running setup.py (path:/tmp/pip-Ew3vl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:59 INFO - Running setup.py (path:/tmp/pip-l_S_Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:59 INFO - Running setup.py (path:/tmp/pip-uVE6k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:59 INFO - Running setup.py (path:/tmp/pip-4eYLcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:59 INFO - Running setup.py (path:/tmp/pip-86u__Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:59 INFO - Running setup.py (path:/tmp/pip-6lI_Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:59 INFO - Running setup.py (path:/tmp/pip-JznNr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:59 INFO - Running setup.py (path:/tmp/pip-dBlesM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:59 INFO - Running setup.py (path:/tmp/pip-jEWA1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:59 INFO - Running setup.py (path:/tmp/pip-QS3kQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:59 INFO - Running setup.py install for manifestparser 04:02:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:59 INFO - Running setup.py install for mozcrash 04:03:00 INFO - Running setup.py install for mozdebug 04:03:00 INFO - Running setup.py install for mozdevice 04:03:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Running setup.py install for mozfile 04:03:00 INFO - Running setup.py install for mozhttpd 04:03:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Running setup.py install for mozinfo 04:03:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Running setup.py install for mozInstall 04:03:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Running setup.py install for mozleak 04:03:00 INFO - Running setup.py install for mozlog 04:03:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Running setup.py install for moznetwork 04:03:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:03:00 INFO - Running setup.py install for mozprocess 04:03:01 INFO - Running setup.py install for mozprofile 04:03:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:03:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:03:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:03:01 INFO - Running setup.py install for mozrunner 04:03:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:03:01 INFO - Running setup.py install for mozscreenshot 04:03:01 INFO - Running setup.py install for moztest 04:03:01 INFO - Running setup.py install for mozversion 04:03:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:03:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:03:01 INFO - Cleaning up... 04:03:01 INFO - Return code: 0 04:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03: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')]} 04:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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')]} 04:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:01 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 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:03:01 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 04:03:01 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 04:03:01 INFO - Using env: {'DISPLAY': ':0', 04:03:01 INFO - 'HOME': '/home/cltbld', 04:03:01 INFO - 'LANG': 'en_US.UTF-8', 04:03:01 INFO - 'LANGUAGE': 'en_US:en', 04:03:01 INFO - 'LOGNAME': 'cltbld', 04:03:01 INFO - 'MAIL': '/var/mail/cltbld', 04:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:01 INFO - 'MOZ_NO_REMOTE': '1', 04:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:01 INFO - 'NO_EM_RESTART': '1', 04:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:01 INFO - 'PWD': '/builds/slave/test', 04:03:01 INFO - 'SHELL': '/bin/bash', 04:03:01 INFO - 'SHLVL': '1', 04:03:01 INFO - 'TERM': 'linux', 04:03:01 INFO - 'TMOUT': '86400', 04:03:01 INFO - 'USER': 'cltbld', 04:03:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:01 INFO - '_': '/tools/buildbot/bin/python'} 04:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:01 INFO - Running setup.py (path:/tmp/pip-k5XOaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:02 INFO - Running setup.py (path:/tmp/pip-Jh_2Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:02 INFO - Running setup.py (path:/tmp/pip-LfvT54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:02 INFO - Running setup.py (path:/tmp/pip-gxlLCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:02 INFO - Running setup.py (path:/tmp/pip-SR9hjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:02 INFO - Running setup.py (path:/tmp/pip-zjGboD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:02 INFO - Running setup.py (path:/tmp/pip-MUalmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:02 INFO - Running setup.py (path:/tmp/pip-mO1Wrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:02 INFO - Running setup.py (path:/tmp/pip-ZNeDOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:02 INFO - Running setup.py (path:/tmp/pip-TKWCtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:02 INFO - Running setup.py (path:/tmp/pip-jk8okX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:02 INFO - Running setup.py (path:/tmp/pip-gYRKeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:02 INFO - Running setup.py (path:/tmp/pip-MZ9th7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:02 INFO - Running setup.py (path:/tmp/pip-m289Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:02 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)) 04:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:02 INFO - Running setup.py (path:/tmp/pip-iPxo1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:03 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)) 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:03 INFO - Running setup.py (path:/tmp/pip-VvTdOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:03 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)) 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:03 INFO - Running setup.py (path:/tmp/pip-fXzdzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:03 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)) 04:03:03 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)) 04:03:03 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)) 04:03:03 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)) 04:03:03 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)) 04:03:03 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)) 04:03:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:03: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 04:03: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 04:03: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 04:03: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 04:03: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 04:03: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 04:03:05 INFO - Downloading blessings-1.6.tar.gz 04:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:03:05 INFO - Installing collected packages: blessings 04:03:05 INFO - Running setup.py install for blessings 04:03:05 INFO - Successfully installed blessings 04:03:05 INFO - Cleaning up... 04:03:05 INFO - Return code: 0 04:03:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:05 INFO - Reading from file tmpfile_stdout 04:03:05 INFO - Current package versions: 04:03:05 INFO - argparse == 1.2.1 04:03:05 INFO - blessings == 1.6 04:03:05 INFO - blobuploader == 1.2.4 04:03:05 INFO - docopt == 0.6.1 04:03:05 INFO - functools32 == 3.2.3-2 04:03:05 INFO - jsonschema == 2.5.1 04:03:05 INFO - manifestparser == 1.1 04:03:05 INFO - mozInstall == 1.12 04:03:05 INFO - mozcrash == 0.17 04:03:05 INFO - mozdebug == 0.1 04:03:05 INFO - mozdevice == 0.48 04:03:05 INFO - mozfile == 1.2 04:03:05 INFO - mozhttpd == 0.7 04:03:05 INFO - mozinfo == 0.9 04:03:05 INFO - mozleak == 0.1 04:03:05 INFO - mozlog == 3.2 04:03:05 INFO - moznetwork == 0.27 04:03:05 INFO - mozprocess == 0.22 04:03:05 INFO - mozprofile == 0.28 04:03:05 INFO - mozrunner == 6.11 04:03:05 INFO - mozscreenshot == 0.1 04:03:05 INFO - mozsystemmonitor == 0.3 04:03:05 INFO - moztest == 0.7 04:03:05 INFO - mozversion == 1.4 04:03:05 INFO - psutil == 3.1.1 04:03:05 INFO - requests == 1.2.3 04:03:05 INFO - wsgiref == 0.1.2 04:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:05 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')]} 04:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:05 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')]} 04:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:05 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 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:03:05 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 04:03:05 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 04:03:05 INFO - Using env: {'DISPLAY': ':0', 04:03:05 INFO - 'HOME': '/home/cltbld', 04:03:05 INFO - 'LANG': 'en_US.UTF-8', 04:03:05 INFO - 'LANGUAGE': 'en_US:en', 04:03:05 INFO - 'LOGNAME': 'cltbld', 04:03:05 INFO - 'MAIL': '/var/mail/cltbld', 04:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:05 INFO - 'MOZ_NO_REMOTE': '1', 04:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:05 INFO - 'NO_EM_RESTART': '1', 04:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:05 INFO - 'PWD': '/builds/slave/test', 04:03:05 INFO - 'SHELL': '/bin/bash', 04:03:05 INFO - 'SHLVL': '1', 04:03:05 INFO - 'TERM': 'linux', 04:03:05 INFO - 'TMOUT': '86400', 04:03:05 INFO - 'USER': 'cltbld', 04:03:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:05 INFO - '_': '/tools/buildbot/bin/python'} 04:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 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)) 04:03:05 INFO - Cleaning up... 04:03:05 INFO - Return code: 0 04:03:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:03:05 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')]} 04:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:05 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')]} 04:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:05 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 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:03:05 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 04:03:05 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 04:03:05 INFO - Using env: {'DISPLAY': ':0', 04:03:05 INFO - 'HOME': '/home/cltbld', 04:03:05 INFO - 'LANG': 'en_US.UTF-8', 04:03:05 INFO - 'LANGUAGE': 'en_US:en', 04:03:05 INFO - 'LOGNAME': 'cltbld', 04:03:05 INFO - 'MAIL': '/var/mail/cltbld', 04:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:05 INFO - 'MOZ_NO_REMOTE': '1', 04:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:05 INFO - 'NO_EM_RESTART': '1', 04:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:05 INFO - 'PWD': '/builds/slave/test', 04:03:05 INFO - 'SHELL': '/bin/bash', 04:03:05 INFO - 'SHLVL': '1', 04:03:05 INFO - 'TERM': 'linux', 04:03:05 INFO - 'TMOUT': '86400', 04:03:05 INFO - 'USER': 'cltbld', 04:03:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:05 INFO - '_': '/tools/buildbot/bin/python'} 04:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:03:05 INFO - Cleaning up... 04:03:05 INFO - Return code: 0 04:03:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:03:05 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')]} 04:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:05 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')]} 04:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f009cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, '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': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', '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 04:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:03:06 INFO - Using env: {'DISPLAY': ':0', 04:03:06 INFO - 'HOME': '/home/cltbld', 04:03:06 INFO - 'LANG': 'en_US.UTF-8', 04:03:06 INFO - 'LANGUAGE': 'en_US:en', 04:03:06 INFO - 'LOGNAME': 'cltbld', 04:03:06 INFO - 'MAIL': '/var/mail/cltbld', 04:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:06 INFO - 'MOZ_NO_REMOTE': '1', 04:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:06 INFO - 'NO_EM_RESTART': '1', 04:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:06 INFO - 'PWD': '/builds/slave/test', 04:03:06 INFO - 'SHELL': '/bin/bash', 04:03:06 INFO - 'SHLVL': '1', 04:03:06 INFO - 'TERM': 'linux', 04:03:06 INFO - 'TMOUT': '86400', 04:03:06 INFO - 'USER': 'cltbld', 04:03:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:06 INFO - '_': '/tools/buildbot/bin/python'} 04:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:06 INFO - Downloading/unpacking flake8 04:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:03:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:03:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 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 04:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:03:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:08 INFO - no previously-included directories found matching 'docs/_build' 04:03:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:03:08 INFO - Running setup.py install for pep8 04:03:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:08 INFO - no previously-included directories found matching 'docs/_build' 04:03:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:03:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:03:09 INFO - Cleaning up... 04:03:09 INFO - Return code: 0 04:03:09 INFO - Running post-action listener: _resource_record_post_action 04:03:09 INFO - Running post-action listener: _start_resource_monitoring 04:03:09 INFO - Starting resource monitoring. 04:03:09 INFO - ##### 04:03:09 INFO - ##### Finished create-virtualenv step (success) 04:03:09 INFO - ##### 04:03:09 INFO - ##### 04:03:09 INFO - ##### Running install step. 04:03:09 INFO - ##### 04:03:09 INFO - Running pre-action listener: _resource_record_pre_action 04:03:09 INFO - Running main action method: install 04:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:09 INFO - Reading from file tmpfile_stdout 04:03:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:03:09 INFO - Reading from file tmpfile_stdout 04:03:09 INFO - Output received: 04:03:09 INFO - Usage: mozinstall [options] installer 04:03:09 INFO - Options: 04:03:09 INFO - -h, --help show this help message and exit 04:03:09 INFO - -d DEST, --destination=DEST 04:03:09 INFO - Directory to install application into. [default: 04:03:09 INFO - "/builds/slave/test"] 04:03:09 INFO - --app=APP Application being installed. [default: firefox] 04:03:09 INFO - mkdir: /builds/slave/test/build/application 04:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:03:26 INFO - Reading from file tmpfile_stdout 04:03:26 INFO - Output received: 04:03:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:03:26 INFO - Running post-action listener: _resource_record_post_action 04:03:26 INFO - ##### 04:03:26 INFO - ##### Finished install step (success) 04:03:26 INFO - ##### 04:03:26 INFO - ##### 04:03:26 INFO - ##### Running run-tests step. 04:03:26 INFO - ##### 04:03:26 INFO - Running pre-action listener: _resource_record_pre_action 04:03:26 INFO - Running main action method: run_tests 04:03:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:03:26 INFO - Python 2.7.3 04:03:26 INFO - Return code: 0 04:03:26 INFO - grabbing minidump binary from tooltool 04:03:26 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')]} 04:03:26 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 0x117e1c0>, '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 0x117f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:03:26 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 04:03:26 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 04:03:26 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 04:03:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:03:26 INFO - Return code: 0 04:03:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:03:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:03:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:03:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:03:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:03:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:03:27 INFO - Return code: 0 04:03:27 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/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 04:03:27 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/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 04:03:27 INFO - Using env: {'DISPLAY': ':0', 04:03:27 INFO - 'HOME': '/home/cltbld', 04:03:27 INFO - 'LANG': 'en_US.UTF-8', 04:03:27 INFO - 'LANGUAGE': 'en_US:en', 04:03:27 INFO - 'LOGNAME': 'cltbld', 04:03:27 INFO - 'MAIL': '/var/mail/cltbld', 04:03:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:27 INFO - 'MOZ_NO_REMOTE': '1', 04:03:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:27 INFO - 'NO_EM_RESTART': '1', 04:03:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:27 INFO - 'PWD': '/builds/slave/test', 04:03:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:27 INFO - 'SHELL': '/bin/bash', 04:03:27 INFO - 'SHLVL': '1', 04:03:27 INFO - 'TERM': 'linux', 04:03:27 INFO - 'TMOUT': '86400', 04:03:27 INFO - 'USER': 'cltbld', 04:03:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241', 04:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:27 INFO - '_': '/tools/buildbot/bin/python'} 04:03:27 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/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 04:03:27 INFO - mozversion application_buildid: 20160616013125 04:03:27 INFO - mozversion application_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 04:03:27 INFO - mozversion application_display_name: Nightly 04:03:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:03:27 INFO - mozversion application_name: Firefox 04:03:27 INFO - mozversion application_remotingname: firefox 04:03:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:03:27 INFO - mozversion application_vendor: Mozilla 04:03:27 INFO - mozversion application_version: 50.0a1 04:03:27 INFO - mozversion platform_buildid: 20160616013125 04:03:27 INFO - mozversion platform_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 04:03:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:03:27 INFO - mozversion platform_version: 50.0a1 04:03:27 INFO - using testdate: 1466075007 04:03:27 INFO - actual date: 1466075007 04:03:27 INFO - starting webserver on 'localhost:49851' 04:03:27 INFO - SUITE-START | Running 2 tests 04:03:27 INFO - TEST-START | dromaeo_css 04:03:27 INFO - operating with platform_type : linux_ 04:03:27 INFO - Initialising browser for dromaeo_css test... 04:03:27 INFO - TEST-INFO | started process 13830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbtbgz7/profile http://localhost:49851/getInfo.html) 04:03:32 INFO - PROCESS | 13830 | __metrics Screen width/height:1600/1200 04:03:32 INFO - PROCESS | 13830 | colorDepth:24 04:03:32 INFO - PROCESS | 13830 | Browser inner width/height: 1024/697 04:03:32 INFO - PROCESS | 13830 | __metrics 04:03:33 ERROR - PROCESS | 13830 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:03:34 INFO - TEST-INFO | 13830: exit 0 04:03:34 INFO - Browser initialized. 04:03:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:34 INFO - TEST-INFO | started process 13951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbtbgz7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:46 INFO - PROCESS | 13951 | RSS: Main: 184664064 04:03:46 INFO - PROCESS | 13951 | 04:04:36 INFO - PROCESS | 13951 | 1466075076457 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] 04:06:44 INFO - PROCESS | 13951 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49851/tests/dromaeo/cssquery-ext.html) 04:06:45 INFO - PROCESS | 13951 | RSS: Main: 189255680 04:06:45 INFO - PROCESS | 13951 | 04:09:47 INFO - PROCESS | 13951 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-ext.html (next: http://localhost:49851/tests/dromaeo/cssquery-jquery.html) 04:09:48 INFO - PROCESS | 13951 | RSS: Main: 187666432 04:09:48 INFO - PROCESS | 13951 | 04:12:50 INFO - PROCESS | 13951 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49851/tests/dromaeo/cssquery-mootools.html) 04:12:50 INFO - PROCESS | 13951 | RSS: Main: 188633088 04:12:50 INFO - PROCESS | 13951 | 04:15:52 INFO - PROCESS | 13951 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49851/tests/dromaeo/cssquery-prototype.html) 04:15:53 INFO - PROCESS | 13951 | RSS: Main: 187170816 04:15:53 INFO - PROCESS | 13951 | 04:18:55 INFO - PROCESS | 13951 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49851/tests/dromaeo/cssquery-yui.html) 04:18:56 INFO - PROCESS | 13951 | RSS: Main: 188370944 04:18:56 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | Cycle 1(1): loaded http://localhost:49851/tests/dromaeo/cssquery-yui.html (next: http://localhost:49851/tests/dromaeo/cssquery-dojo.html) 04:21:58 INFO - PROCESS | 13951 | RSS: Main: 189390848 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | __start_tp_report 04:21:58 INFO - PROCESS | 13951 | _x_x_mozilla_page_load 04:21:58 INFO - PROCESS | 13951 | _x_x_mozilla_page_load_details 04:21:58 INFO - PROCESS | 13951 | |i|pagename|runs| 04:21:58 INFO - PROCESS | 13951 | |0;dojo.html;3108.2074071111865;3147.5436061771056;3164.620245570532;3179.523071539267;3186.3786561620477;5490.670559766417;5492.642978206419;5499.395066542677;5588.972055139719;5617.101263797793;5371.060064488709;5454.972725136378;5461.890762184764;5502.614816962814;5632.718364081789;4917.606591472673;4967.900641987158;5054.570361519275;5098.770555325001;5154.53609175176;665.8212508700047;5065.037642847866;5086.669366491166;5090.567301779334;5112.105381558213;5017.9247311290355;5062.797488100453;5066.620003499734;5067.771950262247;5105.923411148836;5030.798768049273;5032.974835125838;5054.1407960646775;5056.443791182967;5059.139946209153;5042.520960508746;5067.467915868818;5068.366454193226;5079.390473143247;5123.795048198068;5547.694876781776;5572.972135139298;5585.301837270341;5601.243832082658;5604.103343465026;5851.531877449794;5867.325257595388;5896.97051514744;5960.7019649017375;5985.132155837423;5897.587168898179;5931.584789064767;5936.792212272593;5963;5993.310769261503;5501.422350653163;5517.779288828442;5522.06124958762;5522.6134170608075;5523.944760552424;5931;6016.578839481282;6020.668863212565;6051.788187413419;6073.696315184223;5883.02930016551;5898.056310990221;5899.734511946973;5901.704914754245;5906.409359064145;6003.8198854034445;6005.159277701126;6005.39946005396;6014.669193194416;6016.639001659914;5801.593888427854;5863.67749773758;5894.32215295238;5934;5945.435183657545;5770.42295770428;5805.390434004369;5827.067669172997;5862.237909071879;5885.234919460443;4492.124035813051;4505.490660628726;4511.255642818964;4521.1409832131785;4579;3931.5871833457645;3984.541777695602;3989.601039895987;4025.5169379674626;4026.617471340218;5517.972410137923;5632.633878797865;5636.915446268309;5667.716614169275;5712.143178523172;5810.1865738796605;5920.970395148083;5957.225560677084;5969.880602387928;5981.611195272293;5653.321601407857;5658.490735833795;5663.32040155184;5683.318001839723;5714.485696287354;5118.692878427306;5120.129577971754;5166.9224961625605;5167.896642067138;5183.948160518422;6087.421694938974;6106.491003209229;6210.9068363974575;6221.875562488724;6227.408396202353;6010.3689112643415;6038.033914573647;6041.667708276087;6076.848078798065;6101.84745381369;6173.632799852716;6176.938230617816;6215.751369945152;6221.035739460391;6227.626342419469;5748.597598168088;5772.538196944319;5847.152162936435;5923.703814809329;5956.285245770535;5879.823605291848;5885.205497257815;5894.882102358015;5898.174255604133;5934.910976335272;5665.745041473061;5688.886222275614;5721.7425215866215;5725.16985037159;5744.138379243147;5644.887102258014;5738.311402631711;5842.503387211965;5871.911921321098;5880.94119058804;5572.192032155233;5591.329040515164;5612.074007788669;5618.353889302619;5698.344690360662;5718.828435146952;5742.827715168552;5751.993401154865;5776;5787.7395517200985;5527.143292789624;5606.635568688022;5644.153376993484;5692.7722891083895;5753.654780713171 04:21:58 INFO - PROCESS | 13951 | |1;ext.html;562.3589108416403;621.6114928169894;624.4972796898495;630.7666163519499;642.6658137768359;42895.57104428959;44234.11531769363;44321.77839110804;48198.75900620492;48343.791405214884;46498.07003859921;47140.76429617847;47167.292490612585;47270;47430.762846185804;8872.37893347466;8943.50810705411;8998.910010899872;9015.64765285206;9031.59357828896;8808.075152109033;8819.73540793774;8854.911450885505;8865.734027979172;8893.68872089477;8878.200961913426;8897.599608017623;8946.910530894673;8966.462012279251;8997.640094396216;8923.553822308892;8941.329400295004;8951.239144672743;8958.417702849294;8965.506897120657;8803.691870784492;8911.420757650732;8926.553672316359;8927.285817134678;8949.284057275467;43515.564844351786;43804.12391752179;43810;43828.3425748614;44116.3382549262;3542.769719968194;3656;3785.432185172219;3810.5617853946596;3835.5397352317623;32971.17572060694;33467.16332091693;33554.1611459713;33763.15592110193;34105.82947085273;4428.424304840382;4457.219986502381;4475.2168370535355;4551.180787458256;4566.680332376735;361834;362060;364213.1789341063;364499;364504;35884.64115358865;60906.39093609096;61278;61324.38675613276;61493.38506614966;36862.631373686454;36901.63098369035;36994.815025925236;37009;37039.81480092582;14982.10107393538;15022.173780441963;15161.696766064617;15165.696686066216;15168.620784480256;13490.325483725774;13594.932025340007;13630.795538066937;13664.043516953916;13676.726465470834;8160.5103693778565;8195.34437245019;8322.334213262924;8366.414350995372;8387.580620968927;3236.530703048092;3257.990023092849;3266.1181481;3269.133679574867;3276.6231883333244;977.6627063663025;1008.1279693065592;1049.2917280835406;1058.640062378795;1109.7614012987246;31626.525602115988;32550.67449325524;32918.67081329156;33498;33568.16079598029;1098.1983152298867;1111.1721767283425;1149.9597514086968;1209.449700386322;1253.0476837603305;16741;16984;17052.48842534726;17091.658166836594;17130.828691712923;563858;564517;566067;568438;568962;58778.412215877295;59325.406745931985;59522.70238648866;59839.401605984254;59847;1317.8484474285387;1333.7132516508998;1377.827771528559;1410.182094385254;1415.2428450778784;30640.84679576588;31178.532322014733;31440.213994650316;31681.846264225307;32080.35839283248;51062.23406648978;51687.48312516977;51928.74035629949;52384;52386.47613523968;506036;509626;512816;513249;514035;28392.716072839008;28830.279243018253;28884.42231155407;28903.988360407286;29044.854775725988;46756.53243467522;46957.295640564735;46960.53039469562;47211.76394118008;48414.27378589253;41882.37176442417;42824;42999;43598.346024810286;43897.78051109852;40889.38665920073;41268.38097428601;41912;42548.57451425446;42703.78648106739;41385.58614413817;42045.57954420416;42299;42385.152296953274;45475.77262113668;34108.31783364368;37215;38171.809140954116;40516.79741601391;41123.58876411317;28736.281592960342;28751.28121796888;29093.563596545646;29193.562096568992;29274.268143296587 04:21:58 INFO - PROCESS | 13951 | |2;jquery.html;386.73508646577113;388.6696308138081;389.55396071498126;391.6553432978979;419.57413225576045;17681.823181768195;18696.439106826783;19115.235390584377;19134.99999999998;20060.197592096334;18022.5494362641;18789.530261743465;18967.71548426775;18988.145533450992;19057.332993345237;5574.832755017356;5593.916091258634;5681.744321505542;5799.507041901444;5806.303243610772;5636.464535869086;5668.489835914766;5686.857828554299;5724.7137643117885;5765.942340576583;5613.46672066153;5633.746481408326;5723.399043100456;5726.7422965966425;5756.884862302752;5674.687892165929;5686.488216060554;5707.65754054756;5707.914381284263;5723.370429252779;4964.776585053645;5077.974610126963;5083.059633967728;5085.364329458817;5100.336956195708;22002.559948800936;22342.66486002711;22759.772402275932;23119.422014449607;23125.768742312528;2253.6732173834703;2264.558411109834;2279.9658005129936;2293.243229734184;2438.6220135878966;14111.435542578285;14421.78367324491;14659;14715;14823;1833.330834245504;1842.7235914612781;1870.93154317095;1871.822176893193;1911.3023746332487;53681.46318536804;65399.673001634685;66678.3332166677;72227;75777;10267.897321026843;10268.43523606194;10507.422091785025;10587.258891877495;10929.945350273198;14647.194404307866;14723.92638036803;14750.852491475163;14836.184009879344;14861.777073343908;7699.923000770033;8110.972256935766;8203.908003459199;8377.287930525974;8384.203500667427;8045.758627241192;8082.313003394777;8097.190280971856;8196.098429172785;8273.793155171168;6497;6544.70548825304;6726.159230096238;6739.224989126314;6789.524733268624;1913.473794706439;1920.750302460699;1938.6607343714793;1976.2885361269932;1980.4454752669276;380.0631443491806;400.01995111975776;402.9335159698675;410.4909911709459;906.3157316226338;10856.240063195659;10892.183086268562;10975;11065.5020524075;11252;416.8520175337711;420.9810558524874;425.88075338904537;430.05602702069285;451.8057235388814;5665;5744.942550574524;5750.453706897838;5754.827355179267;5858.2677165354335;501009;504758;505989;506818;507140;87868.5606571963;89518;90594.09405905989;91158;93778.53110734402;416.59590197508976;421.97257178283314;424.4227850123829;425.70413562574333;426.6458839163487;10383.376997380181;10414.271001029856;10607.363558186533;10648.361098334124;10686;37091.44362834613;38712.2257554853;39303.41044884272;40577.391339130525;41709.79145104255;46133;58075.41924580869;58541.70729146327;59092.40907591041;59266;7948.16544262844;8277.668893244203;8614.526201059001;8687.478751274944;8766.167214114648;12677.936610316889;13644.386002629706;13650.726985460435;13663.316834158053;13663.658408539866;12030.338331391857;12180;12214.26714397139;12229.877701222875;12375.814362784746;11919.284842909454;12070.758584828078;12096.637100886988;12211.084168687561;12333.814992774936;11896.643100706993;12356.505739770668;12388.256704597752;12496.437660305126;12630.87369126297;7657.923420765944;7846.686132554634;7852.646630901509;8038.397120216124;8497.702580409656;11819.763604728028;11822.172447928562;11881.465334059814;11907.880921190677;12163 04:21:58 INFO - PROCESS | 13951 | |3;mootools.html;1477.5345766083685;1510.8262549806773;1626.5201765479183;1744.4330592557421;1769.6106856491576;7928.16754240805;8221.91778082219;8585.22732954034;8828.470291782498;8886.955565222164;8738.475691458501;8874.068222836606;8897.644094236222;8942.374033817636;8980.326475514346;2315.9652605210936;2355.340504658698;2356.493353928905;2356.9528609427803;2360.7403185649564;2201.3395981205654;2204.492966617679;2235.8770267635273;2242.2264318809985;2253.43664083979;2249.5613355395703;2252.763459836718;2262.8529145605485;2345.589521833681;2346.979064107119;2237.8433509654333;2254.8196144308417;2257.052038143975;2265.4676151104477;2276.3967548599553;2199.0544066051593;2212.25889327074;2212.391592312111;2218.4342992536963;2219.844610877239;8784.64861405543;8874.645014199488;8878.778030549223;8943.150400711922;9024.8646270306;5139.58883289336;5280.3663560373;5283.101872681615;5294.602904782157;5312.2828418163435;3238.902832914993;3266.395716792401;3426.777259478126;3454.464557993515;3454.516367708523;1083.6640641401111;1089.319175515303;1094.5457635081432;1101.6860194844512;1117.3351855645878;12399;12427.502899883993;12428.37858107091;12456.875431245753;12457.128001039931;4651.186042442627;4807.6394270429855;4810.470848206694;4813.518648135158;4829.879253018703;10255.58977640901;10259.948700256451;10265.230107741949;10309.175265978703;10322.12261957742;5162.199859021857;5200.583953283804;5218.817341393033;5261.868453288622;5280.709560974184;4323.113761678848;4785.114753770564;4919.508049195123;4919.803207871717;4935.358403407606;3761.4545890845675;3879.398693202558;3908.4723562318723;3935.960640393617;3952.1898010907694;1261.6341261034197;1287.7682017236987;1295.695511554784;1308.5223893278885;1324.8675132486674;896.66375109334;950.092661508258;962.1340793285958;990.4156547636785;1019.1133713669155;5941.138534912414;6015.729292181863;6041.003234466264;6112.724927378279;6150.415710507495;439.1173740781053;446.1500840898094;446.1990726645614;447.1258689262484;457.97481138537034;4004.8798536043964;4166.125113726091;4166.958330416657;4188.057687020396;4223.324268117087;10339.896601034045;10524.842127368096;10784.622538211124;10790.73023174427;10979.560817567368;11103.167262455348;11189.216754827085;11219.1585631078;11231.831522527169;11272.210945233755;8039.236272554098;8094;8238.794030149174;8239.299659529008;8357.414980951275;5998.7300571473515;6275.592086514362;6333.398327158912;6348.936510634834;6350.333215012357;10092.192624589869;10287.43419111956;10292.845607315747;10343.069123778896;10361.171106311627;10141.695749127539;10441;10469.528871200966;10513.158947284352;10538.209634277306;7661.233876612294;7752.651130699245;7865.882011769713;7871.134175240833;7884.250996155356;8682.262007729161;8716.171963663443;8737.43206691563;8744.519051452231;8758.12418758119;7466.589337586268;7658.617069146632;7810.531368117931;7828.647710852912;7974.202579742211;7805.063392392949;7822.335101516434;7891.210878912063;7948.125706172201;8025.478343907627;7136.286371362822;7160.534565253241;7301.63491825396;7329.267073292842;7346.77959661211;5151.587872970078;5246.31797866275;5250.947490525045;5303.681779093266;5399.217113518596;4969.552740253394;5074.5686616637995;5160.48395160481;5273.78904843802;5278.577713782812 04:21:58 INFO - PROCESS | 13951 | |4;prototype.html;311.9095462315927;322.1222169587873;324.058609738709;324.74183024495534;327.83772032843746;5511.559075273978;5590.916136257949;5716.657000579963;5804.0713485842225;5804.535637149029;5528;5653.4911857932775;5658.236138121352;5682.119271512922;5691.922448306369;4309.504406993196;4338.58783415575;4350.695451318409;4381.61978976623;4419.668524860632;4102.589741025903;4310.52584215736;4338.717983331089;4422.270325396305;4466.8883277917985;4275.657947364203;4299.763513006784;4312.22379971605;4320.4599425071865;4338.609525142737;4324.135172965403;4346.304591265414;4364.214441400547;4366.912661746747;4384.978075109636;3709.51776269086;3728.5898551159353;3811.6760075393627;3823.7896915669626;3829.7893615851117;5474.644148130359;5484.177373394023;5484.972575137139;5528.364238112628;5582.469665381782;4919.458859525485;4929.876753081166;4933.333999910002;4941.258811178352;4955.702657840541;5589.636673616202;5841.6495010299095;5857.4435428634215;5888.764449422018;5913.940860591382;4146.792660366999;4175.665946724254;4184.686148538872;4187.5184353799095;4188.895277618053;6145.600535965148;6169.660668663222;6185.257769067695;6198.148851528303;6198.34917333678;4102.338552886086;4199.538050814408;4245.153358289154;4272.786360681954;4277.123189746095;4304.978475107604;4305.031367942251;4312.762798046075;4324.524302326741;4326.134773045341;4945.565785922115;4955.628327875424;4956.132676781549;4958.479359667255;4992.2761199626575;5833.4749872511675;5968.46283834457;5991.55063370249;6018.705978214705;6024.138534196221;1467.339697136293;1478.912998945774;1480.4966311454157;1486.9107853528824;1494;920.7740410655401;937.1518775508176;939.1359948847077;940.2853831088422;949.2263804998904;5075.7969681212335;5079;5104.617153713486;5109.4379618241965;5171.482851714798;5314.734263286898;5349.063913815066;5370.489803468664;5422.674639521641;5426.375966763872;4960.874648971125;5003.572552801343;5047.596192304607;5109.4379618241965;5180.81867134656;2893.1609833148573;2901.854907254671;2921.255079954598;2930.882764689431;2977.7766667500023;5480.616356855062;5523.585731070186;5530.281063461724;5565.41563135873;5565.6104072714525;5099.796008159707;5318.282031925641;5487.533559647395;5490.615656903979;5511.484341806035;5401.756920938567;5514.6691198528215;5572.93801293524;5577.414371490935;5602.38373778884;5493.505584497414;5494.945050549443;5508.228847961209;5512.3660779010925;5735.76681013584;6029.698515074141;6072.848178795565;6122.693865306628;6144.477719393902;6164.938350616437;6072.696365181811;6391.680415979089;6392.114326273668;6397.936020639734;6405.295417504164;4240.724352917051;4319.697621166614;4366.868993930188;4398.252297109563;4426.203283408889;6148.1085242640465;6169.475594574512;6187.938120618916;6200.596961197508;6207.596506227081;5779.1970894115475;5943.554233432424;5960.791372301948;5969.403059693996;6017.518598512021;5924.585279030426;5961.301029206656;5973.118467682666;5981;5982.970085149721;5665.66006039639;5779.2198053263955;5788.305403351625;5818.9127163093435;5856;5866.6186697864505;5872.794452194153;5916.852078697895;5974.40255974399;5974.924513587596;5767.884642307215;5789.247397838422;5803.897259520678;5816.883662326814;5850.619709718854 04:21:58 INFO - PROCESS | 13951 | |5;yui.html;778.8948491953585;782.5813189943382;796.2236819101375;798.984020319594;806.6007326373444;15581.53255402337;16145.677086458263;16235.83764162358;16553;16665.666686666274;14998;15186.620334491643;15243.84756152438;15267.541973740777;15286.2356882156;653.1867824558432;783.9059312882448;795.6300320351036;795.8527672380628;795.9562224077673;772.8492943875947;796.3509739562238;797.3780451248036;798.7364169823974;800.8038030682462;839.1692224697566;839.4333824668355;841.1840514700762;846.9364797640171;846.9915300847005;832.2592892325835;833.1044127562864;836.7113345895656;836.8033512124646;837.4389159263308;606.693619722042;607.3289015637745;611.2115371171184;611.6635850282327;611.8990366589552;14796.18620975846;14797.40810367584;14850.925745371313;14909.701805963929;14935.25323733809;14909.478168264059;15175.62060948474;15304.387824487007;15340.386384544605;15472.303746331441;12476.126671133025;12492.687682807911;12631.431585578672;12706.872931270662;12789.680257993532;3786.6402691744515;3865.8840234793;3904.1996390740114;3944.4872166618443;3951.8419263229434;72402.18994525126;73254.63372683155;74033;74035.25964740338;74308.62845685791;11379.943100284445;11544.653660390202;11620.244684095507;11627.825582616268;11835.11236657254;22287.44281392978;22398.216062437736;22680.432989175402;22697.751623660857;23409.180678676166;7852.646630901623;7932.04815422153;7987.68049278034;8146.877796833052;8270.710525131592;4581.511008922113;4586.105709386704;4682.906341873211;4692.225782745809;4709.599684026896;3627.9455808162897;3746.5129533160516;3759.4548790425783;3759.642833930772;3781.5840257572195;605.9030555111161;626.2797782550012;631.0597210156833;632.7658766256422;642.5084810120262;575.3096284458667;616.9136320915076;722.3931897206372;723.1105739939903;741.4772585327439;9289.62841486333;9486.762830929281;9637.747762148416;9810.901890981142;10459.267851250339;629.5970578829553;653.0824192010139;684.7740245718901;721.9963900180466;764.7017663111391;4698.88252793676;4891.241857512091;5020.096382651158;5022.698638081727;5028.7737051832755;114612.42693786645;114764.42617787025;115367;115562;118151;96257;98552;100346.4982675082;100849.49575252077;103219.48390258;57222;77096;82058.17941820505;89778.55110724404;91163;9293.210077143518;9458.527073646428;9549;10315.17478601695;10447.164226861985;47719.64756832042;49455;53481.465185347646;53807.461925380245;54119.45880541144;47217;48654.75672621614;49480.50519494903;53913.73043134916;58169.70915145397;13541.86458135406;13741.021180294298;13844.30778461093;13942.302884855919;14046.929765351108;14284.57146285613;14368.209748463934;14696.191709456083;14922.253887305375;15040.699186016438;13913;13966.231857247949;14004.719905601627;14174.433022678977;14314.141151530941;13873.306334683428;14270.64323391882;14490.203038832966;14534;14683.55949321522;13567;13708.725825483236;13717.314134293445;13942.372593233531;14114.435422582981;10925.180611454332;11513.531840210526;11547.4803633835;11696.415179241174;11870.819872953653;11227.7754444909;11631.360275184608;11740.706482337668;11894.524219031488;12082.154249202471 04:21:58 INFO - PROCESS | 13951 | __end_tp_report 04:21:58 INFO - PROCESS | 13951 | __start_cc_report 04:21:58 INFO - PROCESS | 13951 | _x_x_mozilla_cycle_collect,346 04:21:58 INFO - PROCESS | 13951 | __end_cc_report 04:21:58 INFO - PROCESS | 13951 | __startTimestamp1466076118950__endTimestamp 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | ------- Summary: start ------- 04:21:58 INFO - PROCESS | 13951 | Number of tests: 6 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | [#0] dojo.html Cycles:165 Average:5479.10 Median:5692.77 stddev:736.96 (12.9%) stddev-sans-first:715.37 04:21:58 INFO - PROCESS | 13951 | Values: 3108.2 3147.5 3164.6 3179.5 3186.4 5490.7 5492.6 5499.4 5589.0 5617.1 5371.1 5455.0 5461.9 5502.6 5632.7 4917.6 4967.9 5054.6 5098.8 5154.5 665.8 5065.0 5086.7 5090.6 5112.1 5017.9 5062.8 5066.6 5067.8 5105.9 5030.8 5033.0 5054.1 5056.4 5059.1 5042.5 5067.5 5068.4 5079.4 5123.8 5547.7 5573.0 5585.3 5601.2 5604.1 5851.5 5867.3 5897.0 5960.7 5985.1 5897.6 5931.6 5936.8 5963.0 5993.3 5501.4 5517.8 5522.1 5522.6 5523.9 5931.0 6016.6 6020.7 6051.8 6073.7 5883.0 5898.1 5899.7 5901.7 5906.4 6003.8 6005.2 6005.4 6014.7 6016.6 5801.6 5863.7 5894.3 5934.0 5945.4 5770.4 5805.4 5827.1 5862.2 5885.2 4492.1 4505.5 4511.3 4521.1 4579.0 3931.6 3984.5 3989.6 4025.5 4026.6 5518.0 5632.6 5636.9 5667.7 5712.1 5810.2 5921.0 5957.2 5969.9 5981.6 5653.3 5658.5 5663.3 5683.3 5714.5 5118.7 5120.1 5166.9 5167.9 5183.9 6087.4 6106.5 6210.9 6221.9 6227.4 6010.4 6038.0 6041.7 6076.8 6101.8 6173.6 6176.9 6215.8 6221.0 6227.6 5748.6 5772.5 5847.2 5923.7 5956.3 5879.8 5885.2 5894.9 5898.2 5934.9 5665.7 5688.9 5721.7 5725.2 5744.1 5644.9 5738.3 5842.5 5871.9 5880.9 5572.2 5591.3 5612.1 5618.4 5698.3 5718.8 5742.8 5752.0 5776.0 5787.7 5527.1 5606.6 5644.2 5692.8 5753.7 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | [#1] ext.html Cycles:180 Average:62915.91 Median:42859.79 stddev:129882.89 (303.0%) stddev-sans-first:130162.88 04:21:58 INFO - PROCESS | 13951 | Values: 562.4 621.6 624.5 630.8 642.7 42895.6 44234.1 44321.8 48198.8 48343.8 46498.1 47140.8 47167.3 47270.0 47430.8 8872.4 8943.5 8998.9 9015.6 9031.6 8808.1 8819.7 8854.9 8865.7 8893.7 8878.2 8897.6 8946.9 8966.5 8997.6 8923.6 8941.3 8951.2 8958.4 8965.5 8803.7 8911.4 8926.6 8927.3 8949.3 43515.6 43804.1 43810.0 43828.3 44116.3 3542.8 3656.0 3785.4 3810.6 3835.5 32971.2 33467.2 33554.2 33763.2 34105.8 4428.4 4457.2 4475.2 4551.2 4566.7 361834.0 362060.0 364213.2 364499.0 364504.0 35884.6 60906.4 61278.0 61324.4 61493.4 36862.6 36901.6 36994.8 37009.0 37039.8 14982.1 15022.2 15161.7 15165.7 15168.6 13490.3 13594.9 13630.8 13664.0 13676.7 8160.5 8195.3 8322.3 8366.4 8387.6 3236.5 3258.0 3266.1 3269.1 3276.6 977.7 1008.1 1049.3 1058.6 1109.8 31626.5 32550.7 32918.7 33498.0 33568.2 1098.2 1111.2 1150.0 1209.4 1253.0 16741.0 16984.0 17052.5 17091.7 17130.8 563858.0 564517.0 566067.0 568438.0 568962.0 58778.4 59325.4 59522.7 59839.4 59847.0 1317.8 1333.7 1377.8 1410.2 1415.2 30640.8 31178.5 31440.2 31681.8 32080.4 51062.2 51687.5 51928.7 52384.0 52386.5 506036.0 509626.0 512816.0 513249.0 514035.0 28392.7 28830.3 28884.4 28904.0 29044.9 46756.5 46957.3 46960.5 47211.8 48414.3 41882.4 42824.0 42999.0 43598.3 43897.8 40889.4 41268.4 41912.0 42548.6 42703.8 41385.6 42045.6 42299.0 42385.2 45475.8 34108.3 37215.0 38171.8 40516.8 41123.6 28736.3 28751.3 29093.6 29193.6 29274.3 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | [#2] jquery.html Cycles:180 Average:28412.43 Median:20493.94 stddev:83040.51 (405.2%) stddev-sans-first:83246.80 04:21:58 INFO - PROCESS | 13951 | Values: 386.7 388.7 389.6 391.7 419.6 17681.8 18696.4 19115.2 19135.0 20060.2 18022.5 18789.5 18967.7 18988.1 19057.3 5574.8 5593.9 5681.7 5799.5 5806.3 5636.5 5668.5 5686.9 5724.7 5765.9 5613.5 5633.7 5723.4 5726.7 5756.9 5674.7 5686.5 5707.7 5707.9 5723.4 4964.8 5078.0 5083.1 5085.4 5100.3 22002.6 22342.7 22759.8 23119.4 23125.8 2253.7 2264.6 2280.0 2293.2 2438.6 14111.4 14421.8 14659.0 14715.0 14823.0 1833.3 1842.7 1870.9 1871.8 1911.3 53681.5 65399.7 66678.3 72227.0 75777.0 10267.9 10268.4 10507.4 10587.3 10929.9 14647.2 14723.9 14750.9 14836.2 14861.8 7699.9 8111.0 8203.9 8377.3 8384.2 8045.8 8082.3 8097.2 8196.1 8273.8 6497.0 6544.7 6726.2 6739.2 6789.5 1913.5 1920.8 1938.7 1976.3 1980.4 380.1 400.0 402.9 410.5 906.3 10856.2 10892.2 10975.0 11065.5 11252.0 416.9 421.0 425.9 430.1 451.8 5665.0 5744.9 5750.5 5754.8 5858.3 501009.0 504758.0 505989.0 506818.0 507140.0 87868.6 89518.0 90594.1 91158.0 93778.5 416.6 422.0 424.4 425.7 426.6 10383.4 10414.3 10607.4 10648.4 10686.0 37091.4 38712.2 39303.4 40577.4 41709.8 46133.0 58075.4 58541.7 59092.4 59266.0 7948.2 8277.7 8614.5 8687.5 8766.2 12677.9 13644.4 13650.7 13663.3 13663.7 12030.3 12180.0 12214.3 12229.9 12375.8 11919.3 12070.8 12096.6 12211.1 12333.8 11896.6 12356.5 12388.3 12496.4 12630.9 7657.9 7846.7 7852.6 8038.4 8497.7 11819.8 11822.2 11881.5 11907.9 12163.0 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | [#3] mootools.html Cycles:180 Average:5837.84 Median:452.55 stddev:3360.06 (742.5%) stddev-sans-first:3353.51 04:21:58 INFO - PROCESS | 13951 | Values: 1477.5 1510.8 1626.5 1744.4 1769.6 7928.2 8221.9 8585.2 8828.5 8887.0 8738.5 8874.1 8897.6 8942.4 8980.3 2316.0 2355.3 2356.5 2357.0 2360.7 2201.3 2204.5 2235.9 2242.2 2253.4 2249.6 2252.8 2262.9 2345.6 2347.0 2237.8 2254.8 2257.1 2265.5 2276.4 2199.1 2212.3 2212.4 2218.4 2219.8 8784.6 8874.6 8878.8 8943.2 9024.9 5139.6 5280.4 5283.1 5294.6 5312.3 3238.9 3266.4 3426.8 3454.5 3454.5 1083.7 1089.3 1094.5 1101.7 1117.3 12399.0 12427.5 12428.4 12456.9 12457.1 4651.2 4807.6 4810.5 4813.5 4829.9 10255.6 10259.9 10265.2 10309.2 10322.1 5162.2 5200.6 5218.8 5261.9 5280.7 4323.1 4785.1 4919.5 4919.8 4935.4 3761.5 3879.4 3908.5 3936.0 3952.2 1261.6 1287.8 1295.7 1308.5 1324.9 896.7 950.1 962.1 990.4 1019.1 5941.1 6015.7 6041.0 6112.7 6150.4 439.1 446.2 446.2 447.1 458.0 4004.9 4166.1 4167.0 4188.1 4223.3 10339.9 10524.8 10784.6 10790.7 10979.6 11103.2 11189.2 11219.2 11231.8 11272.2 8039.2 8094.0 8238.8 8239.3 8357.4 5998.7 6275.6 6333.4 6348.9 6350.3 10092.2 10287.4 10292.8 10343.1 10361.2 10141.7 10441.0 10469.5 10513.2 10538.2 7661.2 7752.7 7865.9 7871.1 7884.3 8682.3 8716.2 8737.4 8744.5 8758.1 7466.6 7658.6 7810.5 7828.6 7974.2 7805.1 7822.3 7891.2 7948.1 8025.5 7136.3 7160.5 7301.6 7329.3 7346.8 5151.6 5246.3 5250.9 5303.7 5399.2 4969.6 5074.6 5160.5 5273.8 5278.6 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | [#4] prototype.html Cycles:180 Average:4837.10 Median:5484.57 stddev:1431.05 (26.1%) stddev-sans-first:1394.17 04:21:58 INFO - PROCESS | 13951 | Values: 311.9 322.1 324.1 324.7 327.8 5511.6 5590.9 5716.7 5804.1 5804.5 5528.0 5653.5 5658.2 5682.1 5691.9 4309.5 4338.6 4350.7 4381.6 4419.7 4102.6 4310.5 4338.7 4422.3 4466.9 4275.7 4299.8 4312.2 4320.5 4338.6 4324.1 4346.3 4364.2 4366.9 4385.0 3709.5 3728.6 3811.7 3823.8 3829.8 5474.6 5484.2 5485.0 5528.4 5582.5 4919.5 4929.9 4933.3 4941.3 4955.7 5589.6 5841.6 5857.4 5888.8 5913.9 4146.8 4175.7 4184.7 4187.5 4188.9 6145.6 6169.7 6185.3 6198.1 6198.3 4102.3 4199.5 4245.2 4272.8 4277.1 4305.0 4305.0 4312.8 4324.5 4326.1 4945.6 4955.6 4956.1 4958.5 4992.3 5833.5 5968.5 5991.6 6018.7 6024.1 1467.3 1478.9 1480.5 1486.9 1494.0 920.8 937.2 939.1 940.3 949.2 5075.8 5079.0 5104.6 5109.4 5171.5 5314.7 5349.1 5370.5 5422.7 5426.4 4960.9 5003.6 5047.6 5109.4 5180.8 2893.2 2901.9 2921.3 2930.9 2977.8 5480.6 5523.6 5530.3 5565.4 5565.6 5099.8 5318.3 5487.5 5490.6 5511.5 5401.8 5514.7 5572.9 5577.4 5602.4 5493.5 5494.9 5508.2 5512.4 5735.8 6029.7 6072.8 6122.7 6144.5 6164.9 6072.7 6391.7 6392.1 6397.9 6405.3 4240.7 4319.7 4366.9 4398.3 4426.2 6148.1 6169.5 6187.9 6200.6 6207.6 5779.2 5943.6 5960.8 5969.4 6017.5 5924.6 5961.3 5973.1 5981.0 5983.0 5665.7 5779.2 5788.3 5818.9 5856.0 5866.6 5872.8 5916.9 5974.4 5974.9 5767.9 5789.2 5803.9 5816.9 5850.6 04:21:58 INFO - PROCESS | 13951 | 04:21:58 INFO - PROCESS | 13951 | [#5] yui.html Cycles:180 Average:20157.01 Median:4266.68 stddev:28622.80 (670.8%) stddev-sans-first:28666.11 04:21:58 INFO - PROCESS | 13951 | Values: 778.9 782.6 796.2 799.0 806.6 15581.5 16145.7 16235.8 16553.0 16665.7 14998.0 15186.6 15243.8 15267.5 15286.2 653.2 783.9 795.6 795.9 796.0 772.8 796.4 797.4 798.7 800.8 839.2 839.4 841.2 846.9 847.0 832.3 833.1 836.7 836.8 837.4 606.7 607.3 611.2 611.7 611.9 14796.2 14797.4 14850.9 14909.7 14935.3 14909.5 15175.6 15304.4 15340.4 15472.3 12476.1 12492.7 12631.4 12706.9 12789.7 3786.6 3865.9 3904.2 3944.5 3951.8 72402.2 73254.6 74033.0 74035.3 74308.6 11379.9 11544.7 11620.2 11627.8 11835.1 22287.4 22398.2 22680.4 22697.8 23409.2 7852.6 7932.0 7987.7 8146.9 8270.7 4581.5 4586.1 4682.9 4692.2 4709.6 3627.9 3746.5 3759.5 3759.6 3781.6 605.9 626.3 631.1 632.8 642.5 575.3 616.9 722.4 723.1 741.5 9289.6 9486.8 9637.7 9810.9 10459.3 629.6 653.1 684.8 722.0 764.7 4698.9 4891.2 5020.1 5022.7 5028.8 114612.4 114764.4 115367.0 115562.0 118151.0 96257.0 98552.0 100346.5 100849.5 103219.5 57222.0 77096.0 82058.2 89778.6 91163.0 9293.2 9458.5 9549.0 10315.2 10447.2 47719.6 49455.0 53481.5 53807.5 54119.5 47217.0 48654.8 49480.5 53913.7 58169.7 13541.9 13741.0 13844.3 13942.3 14046.9 14284.6 14368.2 14696.2 14922.3 15040.7 13913.0 13966.2 14004.7 14174.4 14314.1 13873.3 14270.6 14490.2 14534.0 14683.6 13567.0 13708.7 13717.3 13942.4 14114.4 10925.2 11513.5 11547.5 11696.4 11870.8 11227.8 11631.4 11740.7 11894.5 12082.2 04:21:58 INFO - PROCESS | 13951 | -------- Summary: end -------- 04:21:58 INFO - PROCESS | 13951 | 04:21:59 INFO - TEST-INFO | 13951: exit 0 04:21:59 INFO - TEST-OK | dromaeo_css | took 1112253ms 04:21:59 INFO - TEST-START | kraken 04:21:59 INFO - operating with platform_type : linux_ 04:21:59 INFO - Initialising browser for kraken test... 04:21:59 INFO - TEST-INFO | started process 14187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqCR6HC/profile http://localhost:49851/getInfo.html) 04:22:05 INFO - PROCESS | 14187 | __metrics Screen width/height:1600/1200 04:22:05 INFO - PROCESS | 14187 | colorDepth:24 04:22:05 INFO - PROCESS | 14187 | Browser inner width/height: 1024/697 04:22:05 INFO - PROCESS | 14187 | __metrics 04:22:06 ERROR - PROCESS | 14187 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:22:07 INFO - TEST-INFO | 14187: exit 0 04:22:07 INFO - Browser initialized. 04:22:07 INFO - Running cycle 1/1 for kraken test... 04:22:07 INFO - TEST-INFO | started process 14307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqCR6HC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:19 INFO - PROCESS | 14307 | RSS: Main: 185004032 04:22:19 INFO - PROCESS | 14307 | 04:22:21 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-beat-detection) 04:22:22 INFO - PROCESS | 14307 | RSS: Main: 190967808 04:22:22 INFO - PROCESS | 14307 | 04:22:25 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-dft) 04:22:25 INFO - PROCESS | 14307 | RSS: Main: 190095360 04:22:25 INFO - PROCESS | 14307 | 04:22:28 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-fft) 04:22:29 INFO - PROCESS | 14307 | RSS: Main: 184750080 04:22:29 INFO - PROCESS | 14307 | 04:22:31 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49851/tests/kraken/driver.html?testName=audio-oscillator) 04:22:32 INFO - PROCESS | 14307 | RSS: Main: 185782272 04:22:32 INFO - PROCESS | 14307 | 04:22:34 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:34 INFO - PROCESS | 14307 | RSS: Main: 185659392 04:22:34 INFO - PROCESS | 14307 | 04:22:38 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49851/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:38 INFO - PROCESS | 14307 | RSS: Main: 186249216 04:22:38 INFO - PROCESS | 14307 | 04:22:42 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49851/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:42 INFO - PROCESS | 14307 | RSS: Main: 184016896 04:22:42 INFO - PROCESS | 14307 | 04:22:45 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49851/tests/kraken/driver.html?testName=json-parse-financial) 04:22:46 INFO - PROCESS | 14307 | RSS: Main: 185024512 04:22:46 INFO - PROCESS | 14307 | 04:22:47 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:22:48 INFO - PROCESS | 14307 | RSS: Main: 185262080 04:22:48 INFO - PROCESS | 14307 | 04:22:50 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:50 INFO - PROCESS | 14307 | RSS: Main: 184958976 04:22:50 INFO - PROCESS | 14307 | 04:22:53 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:53 INFO - PROCESS | 14307 | RSS: Main: 186384384 04:22:53 INFO - PROCESS | 14307 | 04:22:56 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:57 INFO - PROCESS | 14307 | RSS: Main: 186122240 04:22:57 INFO - PROCESS | 14307 | 04:22:59 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:23:00 INFO - PROCESS | 14307 | RSS: Main: 185880576 04:23:00 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | Cycle 1(1): loaded http://localhost:49851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49851/tests/kraken/driver.html?testName=ai-astar) 04:23:02 INFO - PROCESS | 14307 | RSS: Main: 186626048 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | __start_tp_report 04:23:02 INFO - PROCESS | 14307 | _x_x_mozilla_page_load 04:23:02 INFO - PROCESS | 14307 | _x_x_mozilla_page_load_details 04:23:02 INFO - PROCESS | 14307 | |i|pagename|runs| 04:23:02 INFO - PROCESS | 14307 | |0;ai-astar;111;106;111;110;111;112;110;110;112;110 04:23:02 INFO - PROCESS | 14307 | |1;audio-beat-detection;151;130;155;177;130;156;154;126;184;126 04:23:02 INFO - PROCESS | 14307 | |2;audio-dft;163;162;161;163;165;172;162;163;163;161 04:23:02 INFO - PROCESS | 14307 | |3;audio-fft;77;78;76;145;77;75;76;74;160;75 04:23:02 INFO - PROCESS | 14307 | |4;audio-oscillator;85;86;146;86;86;84;140;86;84;134 04:23:02 INFO - PROCESS | 14307 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;118;117;117 04:23:02 INFO - PROCESS | 14307 | |6;imaging-darkroom;146;147;147;148;148;150;147;147;147;149 04:23:02 INFO - PROCESS | 14307 | |7;imaging-desaturate;97;97;96;95;95;95;95;96;96;96 04:23:02 INFO - PROCESS | 14307 | |8;json-parse-financial;55;56;56;56;55;54;53;53;55;54 04:23:02 INFO - PROCESS | 14307 | |9;json-stringify-tinderbox;63;63;63;63;64;63;63;64;63;64 04:23:02 INFO - PROCESS | 14307 | |10;stanford-crypto-aes;81;81;84;83;83;83;83;82;119;88 04:23:02 INFO - PROCESS | 14307 | |11;stanford-crypto-ccm;123;127;137;144;141;130;142;131;141;129 04:23:02 INFO - PROCESS | 14307 | |12;stanford-crypto-pbkdf2;174;162;163;162;161;158;160;165;163;165 04:23:02 INFO - PROCESS | 14307 | |13;stanford-crypto-sha256-iterative;63;65;68;63;65;73;69;62;64;60 04:23:02 INFO - PROCESS | 14307 | __end_tp_report 04:23:02 INFO - PROCESS | 14307 | __start_cc_report 04:23:02 INFO - PROCESS | 14307 | _x_x_mozilla_cycle_collect,940 04:23:02 INFO - PROCESS | 14307 | __end_cc_report 04:23:02 INFO - PROCESS | 14307 | __startTimestamp1466076182360__endTimestamp 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | ------- Summary: start ------- 04:23:02 INFO - PROCESS | 14307 | Number of tests: 14 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.70 (1.5%) stddev-sans-first:1.79 04:23:02 INFO - PROCESS | 14307 | Values: 111.0 106.0 111.0 110.0 111.0 112.0 110.0 110.0 112.0 110.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.50 stddev:20.82 (13.5%) stddev-sans-first:22.07 04:23:02 INFO - PROCESS | 14307 | Values: 151.0 130.0 155.0 177.0 130.0 156.0 154.0 126.0 184.0 126.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.21 (2.0%) stddev-sans-first:3.40 04:23:02 INFO - PROCESS | 14307 | Values: 163.0 162.0 161.0 163.0 165.0 172.0 162.0 163.0 163.0 161.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#3] audio-fft Cycles:10 Average:91.30 Median:76.00 stddev:32.47 (42.7%) stddev-sans-first:34.02 04:23:02 INFO - PROCESS | 14307 | Values: 77.0 78.0 76.0 145.0 77.0 75.0 76.0 74.0 160.0 75.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:85.50 stddev:26.59 (31.1%) stddev-sans-first:27.51 04:23:02 INFO - PROCESS | 14307 | Values: 85.0 86.0 146.0 86.0 86.0 84.0 140.0 86.0 84.0 134.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:23:02 INFO - PROCESS | 14307 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.09 04:23:02 INFO - PROCESS | 14307 | Values: 146.0 147.0 147.0 148.0 148.0 150.0 147.0 147.0 147.0 149.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 04:23:02 INFO - PROCESS | 14307 | Values: 97.0 97.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.16 (2.1%) stddev-sans-first:1.22 04:23:02 INFO - PROCESS | 14307 | Values: 55.0 56.0 56.0 56.0 55.0 54.0 53.0 53.0 55.0 54.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:23:02 INFO - PROCESS | 14307 | Values: 63.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 63.0 64.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.00 stddev:11.52 (13.9%) stddev-sans-first:12.03 04:23:02 INFO - PROCESS | 14307 | Values: 81.0 81.0 84.0 83.0 83.0 83.0 83.0 82.0 119.0 88.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:139.00 stddev:7.37 (5.3%) stddev-sans-first:6.53 04:23:02 INFO - PROCESS | 14307 | Values: 123.0 127.0 137.0 144.0 141.0 130.0 142.0 131.0 141.0 129.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:163.00 stddev:4.32 (2.7%) stddev-sans-first:2.26 04:23:02 INFO - PROCESS | 14307 | Values: 174.0 162.0 163.0 162.0 161.0 158.0 160.0 165.0 163.0 165.0 04:23:02 INFO - PROCESS | 14307 | 04:23:02 INFO - PROCESS | 14307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:3.82 (5.9%) stddev-sans-first:3.97 04:23:02 INFO - PROCESS | 14307 | Values: 63.0 65.0 68.0 63.0 65.0 73.0 69.0 62.0 64.0 60.0 04:23:02 INFO - PROCESS | 14307 | -------- Summary: end -------- 04:23:02 INFO - PROCESS | 14307 | 04:23:03 INFO - TEST-INFO | 14307: exit 0 04:23:03 INFO - TEST-OK | kraken | took 63643ms 04:23:03 INFO - SUITE-END | took 1175s 04:23:03 INFO - Completed test suite (00:19:36) 04:23:03 INFO - javascript benchmark 04:23:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7133.566466056331, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.2074071111865, 3147.5436061771056, 3164.620245570532, 3179.523071539267, 3186.3786561620477, 5490.670559766417, 5492.642978206419, 5499.395066542677, 5588.972055139719, 5617.101263797793, 5371.060064488709, 5454.972725136378, 5461.890762184764, 5502.614816962814, 5632.718364081789, 4917.606591472673, 4967.900641987158, 5054.570361519275, 5098.770555325001, 5154.53609175176, 665.8212508700047, 5065.037642847866, 5086.669366491166, 5090.567301779334, 5112.105381558213, 5017.9247311290355, 5062.797488100453, 5066.620003499734, 5067.771950262247, 5105.923411148836, 5030.798768049273, 5032.974835125838, 5054.1407960646775, 5056.443791182967, 5059.139946209153, 5042.520960508746, 5067.467915868818, 5068.366454193226, 5079.390473143247, 5123.795048198068, 5547.694876781776, 5572.972135139298, 5585.301837270341, 5601.243832082658, 5604.103343465026, 5851.531877449794, 5867.325257595388, 5896.97051514744, 5960.7019649017375, 5985.132155837423, 5897.587168898179, 5931.584789064767, 5936.792212272593, 5963.0, 5993.310769261503, 5501.422350653163, 5517.779288828442, 5522.06124958762, 5522.6134170608075, 5523.944760552424, 5931.0, 6016.578839481282, 6020.668863212565, 6051.788187413419, 6073.696315184223, 5883.02930016551, 5898.056310990221, 5899.734511946973, 5901.704914754245, 5906.409359064145, 6003.8198854034445, 6005.159277701126, 6005.39946005396, 6014.669193194416, 6016.639001659914, 5801.593888427854, 5863.67749773758, 5894.32215295238, 5934.0, 5945.435183657545, 5770.42295770428, 5805.390434004369, 5827.067669172997, 5862.237909071879, 5885.234919460443, 4492.124035813051, 4505.490660628726, 4511.255642818964, 4521.1409832131785, 4579.0, 3931.5871833457645, 3984.541777695602, 3989.601039895987, 4025.5169379674626, 4026.617471340218, 5517.972410137923, 5632.633878797865, 5636.915446268309, 5667.716614169275, 5712.143178523172, 5810.1865738796605, 5920.970395148083, 5957.225560677084, 5969.880602387928, 5981.611195272293, 5653.321601407857, 5658.490735833795, 5663.32040155184, 5683.318001839723, 5714.485696287354, 5118.692878427306, 5120.129577971754, 5166.9224961625605, 5167.896642067138, 5183.948160518422, 6087.421694938974, 6106.491003209229, 6210.9068363974575, 6221.875562488724, 6227.408396202353, 6010.3689112643415, 6038.033914573647, 6041.667708276087, 6076.848078798065, 6101.84745381369, 6173.632799852716, 6176.938230617816, 6215.751369945152, 6221.035739460391, 6227.626342419469, 5748.597598168088, 5772.538196944319, 5847.152162936435, 5923.703814809329, 5956.285245770535, 5879.823605291848, 5885.205497257815, 5894.882102358015, 5898.174255604133, 5934.910976335272, 5665.745041473061, 5688.886222275614, 5721.7425215866215, 5725.16985037159, 5744.138379243147, 5644.887102258014, 5738.311402631711, 5842.503387211965, 5871.911921321098, 5880.94119058804, 5572.192032155233, 5591.329040515164, 5612.074007788669, 5618.353889302619, 5698.344690360662, 5718.828435146952, 5742.827715168552, 5751.993401154865, 5776.0, 5787.7395517200985, 5527.143292789624, 5606.635568688022, 5644.153376993484, 5692.7722891083895, 5753.654780713171], "value": 5430.540566363393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.3589108416403, 621.6114928169894, 624.4972796898495, 630.7666163519499, 642.6658137768359, 42895.57104428959, 44234.11531769363, 44321.77839110804, 48198.75900620492, 48343.791405214884, 46498.07003859921, 47140.76429617847, 47167.292490612585, 47270.0, 47430.762846185804, 8872.37893347466, 8943.50810705411, 8998.910010899872, 9015.64765285206, 9031.59357828896, 8808.075152109033, 8819.73540793774, 8854.911450885505, 8865.734027979172, 8893.68872089477, 8878.200961913426, 8897.599608017623, 8946.910530894673, 8966.462012279251, 8997.640094396216, 8923.553822308892, 8941.329400295004, 8951.239144672743, 8958.417702849294, 8965.506897120657, 8803.691870784492, 8911.420757650732, 8926.553672316359, 8927.285817134678, 8949.284057275467, 43515.564844351786, 43804.12391752179, 43810.0, 43828.3425748614, 44116.3382549262, 3542.769719968194, 3656.0, 3785.432185172219, 3810.5617853946596, 3835.5397352317623, 32971.17572060694, 33467.16332091693, 33554.1611459713, 33763.15592110193, 34105.82947085273, 4428.424304840382, 4457.219986502381, 4475.2168370535355, 4551.180787458256, 4566.680332376735, 361834.0, 362060.0, 364213.1789341063, 364499.0, 364504.0, 35884.64115358865, 60906.39093609096, 61278.0, 61324.38675613276, 61493.38506614966, 36862.631373686454, 36901.63098369035, 36994.815025925236, 37009.0, 37039.81480092582, 14982.10107393538, 15022.173780441963, 15161.696766064617, 15165.696686066216, 15168.620784480256, 13490.325483725774, 13594.932025340007, 13630.795538066937, 13664.043516953916, 13676.726465470834, 8160.5103693778565, 8195.34437245019, 8322.334213262924, 8366.414350995372, 8387.580620968927, 3236.530703048092, 3257.990023092849, 3266.1181481, 3269.133679574867, 3276.6231883333244, 977.6627063663025, 1008.1279693065592, 1049.2917280835406, 1058.640062378795, 1109.7614012987246, 31626.525602115988, 32550.67449325524, 32918.67081329156, 33498.0, 33568.16079598029, 1098.1983152298867, 1111.1721767283425, 1149.9597514086968, 1209.449700386322, 1253.0476837603305, 16741.0, 16984.0, 17052.48842534726, 17091.658166836594, 17130.828691712923, 563858.0, 564517.0, 566067.0, 568438.0, 568962.0, 58778.412215877295, 59325.406745931985, 59522.70238648866, 59839.401605984254, 59847.0, 1317.8484474285387, 1333.7132516508998, 1377.827771528559, 1410.182094385254, 1415.2428450778784, 30640.84679576588, 31178.532322014733, 31440.213994650316, 31681.846264225307, 32080.35839283248, 51062.23406648978, 51687.48312516977, 51928.74035629949, 52384.0, 52386.47613523968, 506036.0, 509626.0, 512816.0, 513249.0, 514035.0, 28392.716072839008, 28830.279243018253, 28884.42231155407, 28903.988360407286, 29044.854775725988, 46756.53243467522, 46957.295640564735, 46960.53039469562, 47211.76394118008, 48414.27378589253, 41882.37176442417, 42824.0, 42999.0, 43598.346024810286, 43897.78051109852, 40889.38665920073, 41268.38097428601, 41912.0, 42548.57451425446, 42703.78648106739, 41385.58614413817, 42045.57954420416, 42299.0, 42385.152296953274, 45475.77262113668, 34108.31783364368, 37215.0, 38171.809140954116, 40516.79741601391, 41123.58876411317, 28736.281592960342, 28751.28121796888, 29093.563596545646, 29193.562096568992, 29274.268143296587], "value": 19411.976329660487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.73508646577113, 388.6696308138081, 389.55396071498126, 391.6553432978979, 419.57413225576045, 17681.823181768195, 18696.439106826783, 19115.235390584377, 19134.99999999998, 20060.197592096334, 18022.5494362641, 18789.530261743465, 18967.71548426775, 18988.145533450992, 19057.332993345237, 5574.832755017356, 5593.916091258634, 5681.744321505542, 5799.507041901444, 5806.303243610772, 5636.464535869086, 5668.489835914766, 5686.857828554299, 5724.7137643117885, 5765.942340576583, 5613.46672066153, 5633.746481408326, 5723.399043100456, 5726.7422965966425, 5756.884862302752, 5674.687892165929, 5686.488216060554, 5707.65754054756, 5707.914381284263, 5723.370429252779, 4964.776585053645, 5077.974610126963, 5083.059633967728, 5085.364329458817, 5100.336956195708, 22002.559948800936, 22342.66486002711, 22759.772402275932, 23119.422014449607, 23125.768742312528, 2253.6732173834703, 2264.558411109834, 2279.9658005129936, 2293.243229734184, 2438.6220135878966, 14111.435542578285, 14421.78367324491, 14659.0, 14715.0, 14823.0, 1833.330834245504, 1842.7235914612781, 1870.93154317095, 1871.822176893193, 1911.3023746332487, 53681.46318536804, 65399.673001634685, 66678.3332166677, 72227.0, 75777.0, 10267.897321026843, 10268.43523606194, 10507.422091785025, 10587.258891877495, 10929.945350273198, 14647.194404307866, 14723.92638036803, 14750.852491475163, 14836.184009879344, 14861.777073343908, 7699.923000770033, 8110.972256935766, 8203.908003459199, 8377.287930525974, 8384.203500667427, 8045.758627241192, 8082.313003394777, 8097.190280971856, 8196.098429172785, 8273.793155171168, 6497.0, 6544.70548825304, 6726.159230096238, 6739.224989126314, 6789.524733268624, 1913.473794706439, 1920.750302460699, 1938.6607343714793, 1976.2885361269932, 1980.4454752669276, 380.0631443491806, 400.01995111975776, 402.9335159698675, 410.4909911709459, 906.3157316226338, 10856.240063195659, 10892.183086268562, 10975.0, 11065.5020524075, 11252.0, 416.8520175337711, 420.9810558524874, 425.88075338904537, 430.05602702069285, 451.8057235388814, 5665.0, 5744.942550574524, 5750.453706897838, 5754.827355179267, 5858.2677165354335, 501009.0, 504758.0, 505989.0, 506818.0, 507140.0, 87868.5606571963, 89518.0, 90594.09405905989, 91158.0, 93778.53110734402, 416.59590197508976, 421.97257178283314, 424.4227850123829, 425.70413562574333, 426.6458839163487, 10383.376997380181, 10414.271001029856, 10607.363558186533, 10648.361098334124, 10686.0, 37091.44362834613, 38712.2257554853, 39303.41044884272, 40577.391339130525, 41709.79145104255, 46133.0, 58075.41924580869, 58541.70729146327, 59092.40907591041, 59266.0, 7948.16544262844, 8277.668893244203, 8614.526201059001, 8687.478751274944, 8766.167214114648, 12677.936610316889, 13644.386002629706, 13650.726985460435, 13663.316834158053, 13663.658408539866, 12030.338331391857, 12180.0, 12214.26714397139, 12229.877701222875, 12375.814362784746, 11919.284842909454, 12070.758584828078, 12096.637100886988, 12211.084168687561, 12333.814992774936, 11896.643100706993, 12356.505739770668, 12388.256704597752, 12496.437660305126, 12630.87369126297, 7657.923420765944, 7846.686132554634, 7852.646630901509, 8038.397120216124, 8497.702580409656, 11819.763604728028, 11822.172447928562, 11881.465334059814, 11907.880921190677, 12163.0], "value": 8288.852068587317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.5345766083685, 1510.8262549806773, 1626.5201765479183, 1744.4330592557421, 1769.6106856491576, 7928.16754240805, 8221.91778082219, 8585.22732954034, 8828.470291782498, 8886.955565222164, 8738.475691458501, 8874.068222836606, 8897.644094236222, 8942.374033817636, 8980.326475514346, 2315.9652605210936, 2355.340504658698, 2356.493353928905, 2356.9528609427803, 2360.7403185649564, 2201.3395981205654, 2204.492966617679, 2235.8770267635273, 2242.2264318809985, 2253.43664083979, 2249.5613355395703, 2252.763459836718, 2262.8529145605485, 2345.589521833681, 2346.979064107119, 2237.8433509654333, 2254.8196144308417, 2257.052038143975, 2265.4676151104477, 2276.3967548599553, 2199.0544066051593, 2212.25889327074, 2212.391592312111, 2218.4342992536963, 2219.844610877239, 8784.64861405543, 8874.645014199488, 8878.778030549223, 8943.150400711922, 9024.8646270306, 5139.58883289336, 5280.3663560373, 5283.101872681615, 5294.602904782157, 5312.2828418163435, 3238.902832914993, 3266.395716792401, 3426.777259478126, 3454.464557993515, 3454.516367708523, 1083.6640641401111, 1089.319175515303, 1094.5457635081432, 1101.6860194844512, 1117.3351855645878, 12399.0, 12427.502899883993, 12428.37858107091, 12456.875431245753, 12457.128001039931, 4651.186042442627, 4807.6394270429855, 4810.470848206694, 4813.518648135158, 4829.879253018703, 10255.58977640901, 10259.948700256451, 10265.230107741949, 10309.175265978703, 10322.12261957742, 5162.199859021857, 5200.583953283804, 5218.817341393033, 5261.868453288622, 5280.709560974184, 4323.113761678848, 4785.114753770564, 4919.508049195123, 4919.803207871717, 4935.358403407606, 3761.4545890845675, 3879.398693202558, 3908.4723562318723, 3935.960640393617, 3952.1898010907694, 1261.6341261034197, 1287.7682017236987, 1295.695511554784, 1308.5223893278885, 1324.8675132486674, 896.66375109334, 950.092661508258, 962.1340793285958, 990.4156547636785, 1019.1133713669155, 5941.138534912414, 6015.729292181863, 6041.003234466264, 6112.724927378279, 6150.415710507495, 439.1173740781053, 446.1500840898094, 446.1990726645614, 447.1258689262484, 457.97481138537034, 4004.8798536043964, 4166.125113726091, 4166.958330416657, 4188.057687020396, 4223.324268117087, 10339.896601034045, 10524.842127368096, 10784.622538211124, 10790.73023174427, 10979.560817567368, 11103.167262455348, 11189.216754827085, 11219.1585631078, 11231.831522527169, 11272.210945233755, 8039.236272554098, 8094.0, 8238.794030149174, 8239.299659529008, 8357.414980951275, 5998.7300571473515, 6275.592086514362, 6333.398327158912, 6348.936510634834, 6350.333215012357, 10092.192624589869, 10287.43419111956, 10292.845607315747, 10343.069123778896, 10361.171106311627, 10141.695749127539, 10441.0, 10469.528871200966, 10513.158947284352, 10538.209634277306, 7661.233876612294, 7752.651130699245, 7865.882011769713, 7871.134175240833, 7884.250996155356, 8682.262007729161, 8716.171963663443, 8737.43206691563, 8744.519051452231, 8758.12418758119, 7466.589337586268, 7658.617069146632, 7810.531368117931, 7828.647710852912, 7974.202579742211, 7805.063392392949, 7822.335101516434, 7891.210878912063, 7948.125706172201, 8025.478343907627, 7136.286371362822, 7160.534565253241, 7301.63491825396, 7329.267073292842, 7346.77959661211, 5151.587872970078, 5246.31797866275, 5250.947490525045, 5303.681779093266, 5399.217113518596, 4969.552740253394, 5074.5686616637995, 5160.48395160481, 5273.78904843802, 5278.577713782812], "value": 4570.5412993190985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.9095462315927, 322.1222169587873, 324.058609738709, 324.74183024495534, 327.83772032843746, 5511.559075273978, 5590.916136257949, 5716.657000579963, 5804.0713485842225, 5804.535637149029, 5528.0, 5653.4911857932775, 5658.236138121352, 5682.119271512922, 5691.922448306369, 4309.504406993196, 4338.58783415575, 4350.695451318409, 4381.61978976623, 4419.668524860632, 4102.589741025903, 4310.52584215736, 4338.717983331089, 4422.270325396305, 4466.8883277917985, 4275.657947364203, 4299.763513006784, 4312.22379971605, 4320.4599425071865, 4338.609525142737, 4324.135172965403, 4346.304591265414, 4364.214441400547, 4366.912661746747, 4384.978075109636, 3709.51776269086, 3728.5898551159353, 3811.6760075393627, 3823.7896915669626, 3829.7893615851117, 5474.644148130359, 5484.177373394023, 5484.972575137139, 5528.364238112628, 5582.469665381782, 4919.458859525485, 4929.876753081166, 4933.333999910002, 4941.258811178352, 4955.702657840541, 5589.636673616202, 5841.6495010299095, 5857.4435428634215, 5888.764449422018, 5913.940860591382, 4146.792660366999, 4175.665946724254, 4184.686148538872, 4187.5184353799095, 4188.895277618053, 6145.600535965148, 6169.660668663222, 6185.257769067695, 6198.148851528303, 6198.34917333678, 4102.338552886086, 4199.538050814408, 4245.153358289154, 4272.786360681954, 4277.123189746095, 4304.978475107604, 4305.031367942251, 4312.762798046075, 4324.524302326741, 4326.134773045341, 4945.565785922115, 4955.628327875424, 4956.132676781549, 4958.479359667255, 4992.2761199626575, 5833.4749872511675, 5968.46283834457, 5991.55063370249, 6018.705978214705, 6024.138534196221, 1467.339697136293, 1478.912998945774, 1480.4966311454157, 1486.9107853528824, 1494.0, 920.7740410655401, 937.1518775508176, 939.1359948847077, 940.2853831088422, 949.2263804998904, 5075.7969681212335, 5079.0, 5104.617153713486, 5109.4379618241965, 5171.482851714798, 5314.734263286898, 5349.063913815066, 5370.489803468664, 5422.674639521641, 5426.375966763872, 4960.874648971125, 5003.572552801343, 5047.596192304607, 5109.4379618241965, 5180.81867134656, 2893.1609833148573, 2901.854907254671, 2921.255079954598, 2930.882764689431, 2977.7766667500023, 5480.616356855062, 5523.585731070186, 5530.281063461724, 5565.41563135873, 5565.6104072714525, 5099.796008159707, 5318.282031925641, 5487.533559647395, 5490.615656903979, 5511.484341806035, 5401.756920938567, 5514.6691198528215, 5572.93801293524, 5577.414371490935, 5602.38373778884, 5493.505584497414, 5494.945050549443, 5508.228847961209, 5512.3660779010925, 5735.76681013584, 6029.698515074141, 6072.848178795565, 6122.693865306628, 6144.477719393902, 6164.938350616437, 6072.696365181811, 6391.680415979089, 6392.114326273668, 6397.936020639734, 6405.295417504164, 4240.724352917051, 4319.697621166614, 4366.868993930188, 4398.252297109563, 4426.203283408889, 6148.1085242640465, 6169.475594574512, 6187.938120618916, 6200.596961197508, 6207.596506227081, 5779.1970894115475, 5943.554233432424, 5960.791372301948, 5969.403059693996, 6017.518598512021, 5924.585279030426, 5961.301029206656, 5973.118467682666, 5981.0, 5982.970085149721, 5665.66006039639, 5779.2198053263955, 5788.305403351625, 5818.9127163093435, 5856.0, 5866.6186697864505, 5872.794452194153, 5916.852078697895, 5974.40255974399, 5974.924513587596, 5767.884642307215, 5789.247397838422, 5803.897259520678, 5816.883662326814, 5850.619709718854], "value": 4371.453708323484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.8948491953585, 782.5813189943382, 796.2236819101375, 798.984020319594, 806.6007326373444, 15581.53255402337, 16145.677086458263, 16235.83764162358, 16553.0, 16665.666686666274, 14998.0, 15186.620334491643, 15243.84756152438, 15267.541973740777, 15286.2356882156, 653.1867824558432, 783.9059312882448, 795.6300320351036, 795.8527672380628, 795.9562224077673, 772.8492943875947, 796.3509739562238, 797.3780451248036, 798.7364169823974, 800.8038030682462, 839.1692224697566, 839.4333824668355, 841.1840514700762, 846.9364797640171, 846.9915300847005, 832.2592892325835, 833.1044127562864, 836.7113345895656, 836.8033512124646, 837.4389159263308, 606.693619722042, 607.3289015637745, 611.2115371171184, 611.6635850282327, 611.8990366589552, 14796.18620975846, 14797.40810367584, 14850.925745371313, 14909.701805963929, 14935.25323733809, 14909.478168264059, 15175.62060948474, 15304.387824487007, 15340.386384544605, 15472.303746331441, 12476.126671133025, 12492.687682807911, 12631.431585578672, 12706.872931270662, 12789.680257993532, 3786.6402691744515, 3865.8840234793, 3904.1996390740114, 3944.4872166618443, 3951.8419263229434, 72402.18994525126, 73254.63372683155, 74033.0, 74035.25964740338, 74308.62845685791, 11379.943100284445, 11544.653660390202, 11620.244684095507, 11627.825582616268, 11835.11236657254, 22287.44281392978, 22398.216062437736, 22680.432989175402, 22697.751623660857, 23409.180678676166, 7852.646630901623, 7932.04815422153, 7987.68049278034, 8146.877796833052, 8270.710525131592, 4581.511008922113, 4586.105709386704, 4682.906341873211, 4692.225782745809, 4709.599684026896, 3627.9455808162897, 3746.5129533160516, 3759.4548790425783, 3759.642833930772, 3781.5840257572195, 605.9030555111161, 626.2797782550012, 631.0597210156833, 632.7658766256422, 642.5084810120262, 575.3096284458667, 616.9136320915076, 722.3931897206372, 723.1105739939903, 741.4772585327439, 9289.62841486333, 9486.762830929281, 9637.747762148416, 9810.901890981142, 10459.267851250339, 629.5970578829553, 653.0824192010139, 684.7740245718901, 721.9963900180466, 764.7017663111391, 4698.88252793676, 4891.241857512091, 5020.096382651158, 5022.698638081727, 5028.7737051832755, 114612.42693786645, 114764.42617787025, 115367.0, 115562.0, 118151.0, 96257.0, 98552.0, 100346.4982675082, 100849.49575252077, 103219.48390258, 57222.0, 77096.0, 82058.17941820505, 89778.55110724404, 91163.0, 9293.210077143518, 9458.527073646428, 9549.0, 10315.17478601695, 10447.164226861985, 47719.64756832042, 49455.0, 53481.465185347646, 53807.461925380245, 54119.45880541144, 47217.0, 48654.75672621614, 49480.50519494903, 53913.73043134916, 58169.70915145397, 13541.86458135406, 13741.021180294298, 13844.30778461093, 13942.302884855919, 14046.929765351108, 14284.57146285613, 14368.209748463934, 14696.191709456083, 14922.253887305375, 15040.699186016438, 13913.0, 13966.231857247949, 14004.719905601627, 14174.433022678977, 14314.141151530941, 13873.306334683428, 14270.64323391882, 14490.203038832966, 14534.0, 14683.55949321522, 13567.0, 13708.725825483236, 13717.314134293445, 13942.372593233531, 14114.435422582981, 10925.180611454332, 11513.531840210526, 11547.4803633835, 11696.415179241174, 11870.819872953653, 11227.7754444909, 11631.360275184608, 11740.706482337668, 11894.524219031488, 12082.154249202471], "value": 7547.414294541901, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 110.0, 111.0, 112.0, 110.0, 110.0, 112.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 155.0, 177.0, 130.0, 156.0, 154.0, 126.0, 184.0, 126.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 163.0, 165.0, 172.0, 162.0, 163.0, 163.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 145.0, 77.0, 75.0, 76.0, 74.0, 160.0, 75.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 146.0, 86.0, 86.0, 84.0, 140.0, 86.0, 84.0, 134.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 148.0, 150.0, 147.0, 147.0, 147.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 54.0, 53.0, 53.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 84.0, 83.0, 83.0, 83.0, 83.0, 82.0, 119.0, 88.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 137.0, 144.0, 141.0, 130.0, 142.0, 131.0, 141.0, 129.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 162.0, 163.0, 162.0, 161.0, 158.0, 160.0, 165.0, 163.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 68.0, 63.0, 65.0, 73.0, 69.0, 62.0, 64.0, 60.0], "value": 65.2, "unit": "score"}]}]} 04:23:03 INFO - Return code: 0 04:23:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:23:03 ERROR - # TBPL SUCCESS # 04:23:03 INFO - Running post-action listener: _resource_record_post_action 04:23:03 INFO - ##### 04:23:03 INFO - ##### Finished run-tests step (success) 04:23:03 INFO - ##### 04:23:03 INFO - Running post-run listener: _resource_record_post_run 04:23:03 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 4096; Write bytes: 550916096; Read time: 4; Write time: 1661244 04:23:03 INFO - TinderboxPrint: CPU usage
13.6% 04:23:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 04:23:03 INFO - TinderboxPrint: I/O write bytes / time
550,916,096 / 1,661,244 04:23:03 INFO - TinderboxPrint: CPU idle
8,226.4 (86.4%) 04:23:03 INFO - TinderboxPrint: CPU user
1,226.8 (12.9%) 04:23:03 INFO - TinderboxPrint: Swap in / out
0 / 0 04:23:03 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 256712704; Read time: 0; Write time: 1132392 04:23:03 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 4096; Write bytes: 294027264; Read time: 4; Write time: 528832 04:23:04 INFO - Running post-run listener: _upload_blobber_files 04:23:04 INFO - Blob upload gear active. 04:23:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:23:04 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 04:23:04 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'] 04:23:04 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 04:23:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:23:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:23:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:23:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:08 INFO - (blobuploader) - INFO - Done attempting. 04:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:23:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:09 INFO - (blobuploader) - INFO - Done attempting. 04:23:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:23:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:23:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:09 INFO - (blobuploader) - INFO - Done attempting. 04:23:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:23:09 INFO - Return code: 0 04:23:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:23:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:23:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2c5e4903a533f9e038f9858b718311718d0f7692ae0314b259e31a6a8afc78f51ac5a371ce54cf983fb420869cb86b2f513f17afff18894465e98175101cf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e559fcddec135a871134bb68c3af79cc52e0be41131f4531ec8311b29c2d743aa7c4bacf0d4b8163d1bd984a762e7ba1e33dc573a2ef72b5d34993c53b5b739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dcc7f222b5e50b45cafeeabe5d6f59615429a8cde0ffed53bea401127a3038e24b52dd0819583211e64909c090808bbb2443284669cfb9d6f96a2b8e56dee7d"} 04:23:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:23:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:23:09 INFO - Contents: 04:23:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2c5e4903a533f9e038f9858b718311718d0f7692ae0314b259e31a6a8afc78f51ac5a371ce54cf983fb420869cb86b2f513f17afff18894465e98175101cf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e559fcddec135a871134bb68c3af79cc52e0be41131f4531ec8311b29c2d743aa7c4bacf0d4b8163d1bd984a762e7ba1e33dc573a2ef72b5d34993c53b5b739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dcc7f222b5e50b45cafeeabe5d6f59615429a8cde0ffed53bea401127a3038e24b52dd0819583211e64909c090808bbb2443284669cfb9d6f96a2b8e56dee7d"} 04:23:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:23:09 INFO - Copying logs to upload dir... 04:23:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:23:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.435138 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-16 04:23:09.370746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:09.374083) ========= 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=df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241 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/b2c5e4903a533f9e038f9858b718311718d0f7692ae0314b259e31a6a8afc78f51ac5a371ce54cf983fb420869cb86b2f513f17afff18894465e98175101cf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e559fcddec135a871134bb68c3af79cc52e0be41131f4531ec8311b29c2d743aa7c4bacf0d4b8163d1bd984a762e7ba1e33dc573a2ef72b5d34993c53b5b739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dcc7f222b5e50b45cafeeabe5d6f59615429a8cde0ffed53bea401127a3038e24b52dd0819583211e64909c090808bbb2443284669cfb9d6f96a2b8e56dee7d"} build_url:https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2c5e4903a533f9e038f9858b718311718d0f7692ae0314b259e31a6a8afc78f51ac5a371ce54cf983fb420869cb86b2f513f17afff18894465e98175101cf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e559fcddec135a871134bb68c3af79cc52e0be41131f4531ec8311b29c2d743aa7c4bacf0d4b8163d1bd984a762e7ba1e33dc573a2ef72b5d34993c53b5b739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dcc7f222b5e50b45cafeeabe5d6f59615429a8cde0ffed53bea401127a3038e24b52dd0819583211e64909c090808bbb2443284669cfb9d6f96a2b8e56dee7d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:09.399688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:09.400066) ========= 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=df17445c3590ff7897617a0e00000225-1466073770.404921-1459136241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:09.483926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 04:23:09.484262) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 04:23:09.484616) ========= ========= Total master_lag: 0.18 =========