builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1464801186.15 results: success (0) buildid: 20160601073118 builduid: f4332d6d67d34695a6bfcd81adb8da75 revision: 111970c738234569c8c180319155327316335deb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.151342) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.151805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.152084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.166639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.166955) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 10:13:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.2M=0s 2016-06-01 10:13:06 (97.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.324792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.325107) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018028 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.374615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:06.374967) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 111970c738234569c8c180319155327316335deb --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 111970c738234569c8c180319155327316335deb --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=934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 10:13:06,794 truncating revision to first 12 chars 2016-06-01 10:13:06,794 Setting DEBUG logging. 2016-06-01 10:13:06,794 attempt 1/10 2016-06-01 10:13:06,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/111970c73823?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 10:13:07,117 unpacking tar archive at: mozilla-central-111970c73823/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652747 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:07.037761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:07.038090) ========= script_repo_revision: 111970c738234569c8c180319155327316335deb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:07.038500) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:07.038772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 10:13:07.045785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-01 10:13:07.046119) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:07 INFO - MultiFileLogger online at 20160601 10:13:07 in /builds/slave/test 10:13:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:13:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:07 INFO - {'append_to_log': False, 10:13:07 INFO - 'base_work_dir': '/builds/slave/test', 10:13:07 INFO - 'blob_upload_branch': 'Firefox', 10:13:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:07 INFO - 'branch': 'Firefox', 10:13:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:07 INFO - 'config_files': ('talos/linux_config.py',), 10:13:07 INFO - 'default_actions': ('clobber', 10:13:07 INFO - 'read-buildbot-config', 10:13:07 INFO - 'download-and-extract', 10:13:07 INFO - 'populate-webroot', 10:13:07 INFO - 'create-virtualenv', 10:13:07 INFO - 'install', 10:13:07 INFO - 'run-tests'), 10:13:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:07 INFO - 'download_minidump_stackwalk': True, 10:13:07 INFO - 'download_symbols': 'ondemand', 10:13:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:07 INFO - 'installer_path': 'installer.exe', 10:13:07 INFO - 'log_level': 'info', 10:13:07 INFO - 'log_name': 'talos', 10:13:07 INFO - 'log_to_console': True, 10:13:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:07 INFO - 'opt_config_files': (), 10:13:07 INFO - 'pip_index': False, 10:13:07 INFO - 'sps_profile': False, 10:13:07 INFO - 'sps_profile_interval': 0, 10:13:07 INFO - 'suite': 'dromaeojs', 10:13:07 INFO - 'system_bits': '32', 10:13:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:07 INFO - 'title': 'talos-linux64-ix-057', 10:13:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:07 INFO - 'use_talos_json': True, 10:13:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:07 INFO - 'work_dir': 'build'} 10:13:07 INFO - ##### 10:13:07 INFO - ##### Running clobber step. 10:13:07 INFO - ##### 10:13:07 INFO - Running pre-action listener: _resource_record_pre_action 10:13:07 INFO - Running main action method: clobber 10:13:07 INFO - rmtree: /builds/slave/test/build 10:13:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:08 INFO - Running post-action listener: _resource_record_post_action 10:13:08 INFO - ##### 10:13:08 INFO - ##### Finished clobber step (success) 10:13:08 INFO - ##### 10:13:08 INFO - ##### 10:13:08 INFO - ##### Running read-buildbot-config step. 10:13:08 INFO - ##### 10:13:08 INFO - Running pre-action listener: _resource_record_pre_action 10:13:08 INFO - Running main action method: read_buildbot_config 10:13:08 INFO - Using buildbot properties: 10:13:08 INFO - { 10:13:08 INFO - "project": "", 10:13:08 INFO - "product": "firefox", 10:13:08 INFO - "script_repo_revision": "production", 10:13:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:13:08 INFO - "repository": "", 10:13:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:13:08 INFO - "buildid": "20160601073118", 10:13:08 INFO - "pgo_build": "True", 10:13:08 INFO - "basedir": "/builds/slave/test", 10:13:08 INFO - "buildnumber": 464, 10:13:08 INFO - "slavename": "talos-linux64-ix-057", 10:13:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:13:08 INFO - "platform": "ubuntu64_hw", 10:13:08 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:13:08 INFO - "branch": "mozilla-central", 10:13:08 INFO - "repo_path": "mozilla-central", 10:13:08 INFO - "revision": "111970c738234569c8c180319155327316335deb", 10:13:08 INFO - "stage_platform": "linux64-pgo", 10:13:08 INFO - "builduid": "f4332d6d67d34695a6bfcd81adb8da75", 10:13:08 INFO - "slavebuilddir": "test" 10:13:08 INFO - } 10:13:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:13:08 INFO - Running post-action listener: _resource_record_post_action 10:13:08 INFO - ##### 10:13:08 INFO - ##### Finished read-buildbot-config step (success) 10:13:08 INFO - ##### 10:13:08 INFO - ##### 10:13:08 INFO - ##### Running download-and-extract step. 10:13:08 INFO - ##### 10:13:08 INFO - Running pre-action listener: _resource_record_pre_action 10:13:08 INFO - Running main action method: download_and_extract 10:13:08 INFO - mkdir: /builds/slave/test/build/tests 10:13:08 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')]} 10:13:08 INFO - https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:13:09 INFO - Downloaded 1361 bytes. 10:13:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:13:09 INFO - Using the following test package requirements: 10:13:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:13:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'jsshell-linux-x86_64.zip'], 10:13:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:13:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:13:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:13:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:13:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:09 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')]} 10:13:09 INFO - https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:10 INFO - Downloaded 24422633 bytes. 10:13:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:13:11 INFO - Return code: 0 10:13:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:11 INFO - https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:12 INFO - Downloaded 24422633 bytes. 10:13:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:13:14 INFO - Return code: 0 10:13:14 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')]} 10:13:14 INFO - https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:13:15 INFO - Downloaded 10834055 bytes. 10:13:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:13:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:13:15 INFO - Return code: 0 10:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:15 INFO - https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:13:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:13:16 INFO - Downloaded 59019037 bytes. 10:13:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:16 INFO - mkdir: /builds/slave/test/properties 10:13:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:16 INFO - Contents: 10:13:16 INFO - build_url:https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:13:17 INFO - Running post-action listener: _resource_record_post_action 10:13:17 INFO - Running post-action listener: set_extra_try_arguments 10:13:17 INFO - ##### 10:13:17 INFO - ##### Finished download-and-extract step (success) 10:13:17 INFO - ##### 10:13:17 INFO - ##### 10:13:17 INFO - ##### Running populate-webroot step. 10:13:17 INFO - ##### 10:13:17 INFO - Running pre-action listener: _resource_record_pre_action 10:13:17 INFO - Running main action method: populate_webroot 10:13:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:17 INFO - '--tppagecycles', 10:13:17 INFO - '7'], 10:13:17 INFO - 'tests': ['tsvgm']}}, 10:13:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['damp', 'tps']}, 10:13:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'tests': ['damp', 'tps']}, 10:13:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['dromaeo_dom']}, 10:13:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['a11yr', 10:13:17 INFO - 'ts_paint', 10:13:17 INFO - 'tpaint', 10:13:17 INFO - 'sessionrestore', 10:13:17 INFO - 'sessionrestore_no_auto_restore', 10:13:17 INFO - 'tabpaint']}, 10:13:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['tsvgx', 10:13:17 INFO - 'tsvgr_opacity', 10:13:17 INFO - 'tart', 10:13:17 INFO - 'tscrollx', 10:13:17 INFO - 'cart']}, 10:13:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:17 INFO - 'tsvgr_opacity', 10:13:17 INFO - 'tart', 10:13:17 INFO - 'tscrollx', 10:13:17 INFO - 'cart']}, 10:13:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--disable-e10s'], 10:13:17 INFO - 'tests': ['tp5o']}, 10:13:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'tests': ['tp5o']}, 10:13:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--disable-e10s', 10:13:17 INFO - '--xperf_path', 10:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:17 INFO - 'tests': ['tp5n']}, 10:13:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:17 INFO - 'talos_options': ['--xperf_path', 10:13:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:17 INFO - 'tests': ['tp5n']}}, 10:13:17 INFO - 'talos.zip': {'path': '', 10:13:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:17 INFO - Running post-action listener: _resource_record_post_action 10:13:17 INFO - ##### 10:13:17 INFO - ##### Finished populate-webroot step (success) 10:13:17 INFO - ##### 10:13:17 INFO - ##### 10:13:17 INFO - ##### Running create-virtualenv step. 10:13:17 INFO - ##### 10:13:17 INFO - Running pre-action listener: _resource_record_pre_action 10:13:17 INFO - Running main action method: create_virtualenv 10:13:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:13:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:17 INFO - Using real prefix '/usr' 10:13:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:20 INFO - Installing pip.................done. 10:13:20 INFO - Return code: 0 10:13:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:13:20 INFO - Using env: {'DISPLAY': ':0', 10:13:20 INFO - 'HOME': '/home/cltbld', 10:13:20 INFO - 'LANG': 'en_US.UTF-8', 10:13:20 INFO - 'LANGUAGE': 'en_US:en', 10:13:20 INFO - 'LOGNAME': 'cltbld', 10:13:20 INFO - 'MAIL': '/var/mail/cltbld', 10:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:20 INFO - 'MOZ_NO_REMOTE': '1', 10:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:20 INFO - 'NO_EM_RESTART': '1', 10:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:20 INFO - 'PWD': '/builds/slave/test', 10:13:20 INFO - 'SHELL': '/bin/bash', 10:13:20 INFO - 'SHLVL': '1', 10:13:20 INFO - 'TERM': 'linux', 10:13:20 INFO - 'TMOUT': '86400', 10:13:20 INFO - 'USER': 'cltbld', 10:13:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:20 INFO - '_': '/tools/buildbot/bin/python'} 10:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:13:20 INFO - Cleaning up... 10:13:20 INFO - Return code: 0 10:13:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:13:20 INFO - Using env: {'DISPLAY': ':0', 10:13:20 INFO - 'HOME': '/home/cltbld', 10:13:20 INFO - 'LANG': 'en_US.UTF-8', 10:13:20 INFO - 'LANGUAGE': 'en_US:en', 10:13:20 INFO - 'LOGNAME': 'cltbld', 10:13:20 INFO - 'MAIL': '/var/mail/cltbld', 10:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:20 INFO - 'MOZ_NO_REMOTE': '1', 10:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:20 INFO - 'NO_EM_RESTART': '1', 10:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:20 INFO - 'PWD': '/builds/slave/test', 10:13:20 INFO - 'SHELL': '/bin/bash', 10:13:20 INFO - 'SHLVL': '1', 10:13:20 INFO - 'TERM': 'linux', 10:13:20 INFO - 'TMOUT': '86400', 10:13:20 INFO - 'USER': 'cltbld', 10:13:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:20 INFO - '_': '/tools/buildbot/bin/python'} 10:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:20 INFO - Downloading/unpacking psutil>=3.1.1 10:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:22 INFO - Installing collected packages: psutil 10:13:22 INFO - Running setup.py install for psutil 10:13:22 INFO - building 'psutil._psutil_linux' extension 10:13:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:13:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:13:22 INFO - building 'psutil._psutil_posix' extension 10:13:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:13:23 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 10:13:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:23 INFO - Successfully installed psutil 10:13:23 INFO - Cleaning up... 10:13:23 INFO - Return code: 0 10:13:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:13:23 INFO - Using env: {'DISPLAY': ':0', 10:13:23 INFO - 'HOME': '/home/cltbld', 10:13:23 INFO - 'LANG': 'en_US.UTF-8', 10:13:23 INFO - 'LANGUAGE': 'en_US:en', 10:13:23 INFO - 'LOGNAME': 'cltbld', 10:13:23 INFO - 'MAIL': '/var/mail/cltbld', 10:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:23 INFO - 'MOZ_NO_REMOTE': '1', 10:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:23 INFO - 'NO_EM_RESTART': '1', 10:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:23 INFO - 'PWD': '/builds/slave/test', 10:13:23 INFO - 'SHELL': '/bin/bash', 10:13:23 INFO - 'SHLVL': '1', 10:13:23 INFO - 'TERM': 'linux', 10:13:23 INFO - 'TMOUT': '86400', 10:13:23 INFO - 'USER': 'cltbld', 10:13:23 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:23 INFO - '_': '/tools/buildbot/bin/python'} 10:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:25 INFO - Installing collected packages: mozsystemmonitor 10:13:25 INFO - Running setup.py install for mozsystemmonitor 10:13:25 INFO - Successfully installed mozsystemmonitor 10:13:25 INFO - Cleaning up... 10:13:25 INFO - Return code: 0 10:13:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:13:25 INFO - Using env: {'DISPLAY': ':0', 10:13:25 INFO - 'HOME': '/home/cltbld', 10:13:25 INFO - 'LANG': 'en_US.UTF-8', 10:13:25 INFO - 'LANGUAGE': 'en_US:en', 10:13:25 INFO - 'LOGNAME': 'cltbld', 10:13:25 INFO - 'MAIL': '/var/mail/cltbld', 10:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:25 INFO - 'MOZ_NO_REMOTE': '1', 10:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:25 INFO - 'NO_EM_RESTART': '1', 10:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:25 INFO - 'PWD': '/builds/slave/test', 10:13:25 INFO - 'SHELL': '/bin/bash', 10:13:25 INFO - 'SHLVL': '1', 10:13:25 INFO - 'TERM': 'linux', 10:13:25 INFO - 'TMOUT': '86400', 10:13:25 INFO - 'USER': 'cltbld', 10:13:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:25 INFO - '_': '/tools/buildbot/bin/python'} 10:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:27 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:28 INFO - Downloading docopt-0.6.1.tar.gz 10:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:28 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:28 INFO - Running setup.py install for blobuploader 10:13:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:28 INFO - Running setup.py install for requests 10:13:28 INFO - Running setup.py install for docopt 10:13:28 INFO - Successfully installed blobuploader requests docopt 10:13:28 INFO - Cleaning up... 10:13:28 INFO - Return code: 0 10:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:13:28 INFO - Using env: {'DISPLAY': ':0', 10:13:28 INFO - 'HOME': '/home/cltbld', 10:13:28 INFO - 'LANG': 'en_US.UTF-8', 10:13:28 INFO - 'LANGUAGE': 'en_US:en', 10:13:28 INFO - 'LOGNAME': 'cltbld', 10:13:28 INFO - 'MAIL': '/var/mail/cltbld', 10:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:28 INFO - 'MOZ_NO_REMOTE': '1', 10:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:28 INFO - 'NO_EM_RESTART': '1', 10:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:28 INFO - 'PWD': '/builds/slave/test', 10:13:28 INFO - 'SHELL': '/bin/bash', 10:13:28 INFO - 'SHLVL': '1', 10:13:28 INFO - 'TERM': 'linux', 10:13:28 INFO - 'TMOUT': '86400', 10:13:28 INFO - 'USER': 'cltbld', 10:13:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:28 INFO - '_': '/tools/buildbot/bin/python'} 10:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:29 INFO - Running setup.py (path:/tmp/pip-maCpHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:29 INFO - Running setup.py (path:/tmp/pip-5UCUkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:29 INFO - Running setup.py (path:/tmp/pip-LyiU03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:29 INFO - Running setup.py (path:/tmp/pip-MwCtr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:29 INFO - Running setup.py (path:/tmp/pip-1R83ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:29 INFO - Running setup.py (path:/tmp/pip-JYvur9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:29 INFO - Running setup.py (path:/tmp/pip-RSehZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:29 INFO - Running setup.py (path:/tmp/pip-dG67Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:29 INFO - Running setup.py (path:/tmp/pip-h6gELM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:29 INFO - Running setup.py (path:/tmp/pip-9ofvyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:29 INFO - Running setup.py (path:/tmp/pip-fAp2uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:29 INFO - Running setup.py (path:/tmp/pip-4I83ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:30 INFO - Running setup.py (path:/tmp/pip-Yk3FIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:30 INFO - Running setup.py (path:/tmp/pip-arw1sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:30 INFO - Running setup.py (path:/tmp/pip-ULZAbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:30 INFO - Running setup.py (path:/tmp/pip-240HQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:30 INFO - Running setup.py (path:/tmp/pip-h96HRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:30 INFO - Running setup.py install for manifestparser 10:13:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Running setup.py install for mozcrash 10:13:30 INFO - Running setup.py install for mozdebug 10:13:30 INFO - Running setup.py install for mozdevice 10:13:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:30 INFO - Running setup.py install for mozfile 10:13:30 INFO - Running setup.py install for mozhttpd 10:13:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Running setup.py install for mozinfo 10:13:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Running setup.py install for mozInstall 10:13:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Running setup.py install for mozleak 10:13:31 INFO - Running setup.py install for mozlog 10:13:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Running setup.py install for moznetwork 10:13:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Running setup.py install for mozprocess 10:13:31 INFO - Running setup.py install for mozprofile 10:13:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Running setup.py install for mozrunner 10:13:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:31 INFO - Running setup.py install for mozscreenshot 10:13:31 INFO - Running setup.py install for moztest 10:13:32 INFO - Running setup.py install for mozversion 10:13:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:32 INFO - Cleaning up... 10:13:32 INFO - Return code: 0 10:13:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:13:32 INFO - Using env: {'DISPLAY': ':0', 10:13:32 INFO - 'HOME': '/home/cltbld', 10:13:32 INFO - 'LANG': 'en_US.UTF-8', 10:13:32 INFO - 'LANGUAGE': 'en_US:en', 10:13:32 INFO - 'LOGNAME': 'cltbld', 10:13:32 INFO - 'MAIL': '/var/mail/cltbld', 10:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:32 INFO - 'MOZ_NO_REMOTE': '1', 10:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:32 INFO - 'NO_EM_RESTART': '1', 10:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:32 INFO - 'PWD': '/builds/slave/test', 10:13:32 INFO - 'SHELL': '/bin/bash', 10:13:32 INFO - 'SHLVL': '1', 10:13:32 INFO - 'TERM': 'linux', 10:13:32 INFO - 'TMOUT': '86400', 10:13:32 INFO - 'USER': 'cltbld', 10:13:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:32 INFO - '_': '/tools/buildbot/bin/python'} 10:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:32 INFO - Running setup.py (path:/tmp/pip-FdUL4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:32 INFO - Running setup.py (path:/tmp/pip-EscDTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:32 INFO - Running setup.py (path:/tmp/pip-6HybTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:32 INFO - Running setup.py (path:/tmp/pip-RbZ5GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:32 INFO - Running setup.py (path:/tmp/pip-WfTRzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:32 INFO - Running setup.py (path:/tmp/pip-GCxlt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:32 INFO - Running setup.py (path:/tmp/pip-7hzwto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:32 INFO - Running setup.py (path:/tmp/pip-8VLN6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:32 INFO - Running setup.py (path:/tmp/pip-bRpine-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:33 INFO - Running setup.py (path:/tmp/pip-DGnrgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:33 INFO - Running setup.py (path:/tmp/pip-t_yh1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:33 INFO - Running setup.py (path:/tmp/pip-8vPM2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:33 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)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:33 INFO - Running setup.py (path:/tmp/pip-4A6IRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:33 INFO - Running setup.py (path:/tmp/pip-l0EdLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:33 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)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:33 INFO - Running setup.py (path:/tmp/pip-SQx_Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:33 INFO - Running setup.py (path:/tmp/pip-665iwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:13:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:33 INFO - Running setup.py (path:/tmp/pip-N3xlmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:13:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:35 INFO - Downloading blessings-1.6.tar.gz 10:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:35 INFO - Installing collected packages: blessings 10:13:35 INFO - Running setup.py install for blessings 10:13:35 INFO - Successfully installed blessings 10:13:35 INFO - Cleaning up... 10:13:35 INFO - Return code: 0 10:13:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:35 INFO - Reading from file tmpfile_stdout 10:13:35 INFO - Current package versions: 10:13:35 INFO - argparse == 1.2.1 10:13:35 INFO - blessings == 1.6 10:13:35 INFO - blobuploader == 1.2.4 10:13:35 INFO - docopt == 0.6.1 10:13:35 INFO - manifestparser == 1.1 10:13:35 INFO - mozInstall == 1.12 10:13:35 INFO - mozcrash == 0.17 10:13:35 INFO - mozdebug == 0.1 10:13:35 INFO - mozdevice == 0.48 10:13:35 INFO - mozfile == 1.2 10:13:35 INFO - mozhttpd == 0.7 10:13:35 INFO - mozinfo == 0.9 10:13:35 INFO - mozleak == 0.1 10:13:35 INFO - mozlog == 3.2 10:13:35 INFO - moznetwork == 0.27 10:13:35 INFO - mozprocess == 0.22 10:13:35 INFO - mozprofile == 0.28 10:13:35 INFO - mozrunner == 6.11 10:13:35 INFO - mozscreenshot == 0.1 10:13:35 INFO - mozsystemmonitor == 0.3 10:13:35 INFO - moztest == 0.7 10:13:35 INFO - mozversion == 1.4 10:13:35 INFO - psutil == 3.1.1 10:13:35 INFO - requests == 1.2.3 10:13:35 INFO - wsgiref == 0.1.2 10:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:35 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 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:35 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 10:13:35 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 10:13:35 INFO - Using env: {'DISPLAY': ':0', 10:13:35 INFO - 'HOME': '/home/cltbld', 10:13:35 INFO - 'LANG': 'en_US.UTF-8', 10:13:35 INFO - 'LANGUAGE': 'en_US:en', 10:13:35 INFO - 'LOGNAME': 'cltbld', 10:13:35 INFO - 'MAIL': '/var/mail/cltbld', 10:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:35 INFO - 'MOZ_NO_REMOTE': '1', 10:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:35 INFO - 'NO_EM_RESTART': '1', 10:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:35 INFO - 'PWD': '/builds/slave/test', 10:13:35 INFO - 'SHELL': '/bin/bash', 10:13:35 INFO - 'SHLVL': '1', 10:13:35 INFO - 'TERM': 'linux', 10:13:35 INFO - 'TMOUT': '86400', 10:13:35 INFO - 'USER': 'cltbld', 10:13:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:35 INFO - '_': '/tools/buildbot/bin/python'} 10:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:13:36 INFO - Cleaning up... 10:13:36 INFO - Return code: 0 10:13:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:13:36 INFO - Using env: {'DISPLAY': ':0', 10:13:36 INFO - 'HOME': '/home/cltbld', 10:13:36 INFO - 'LANG': 'en_US.UTF-8', 10:13:36 INFO - 'LANGUAGE': 'en_US:en', 10:13:36 INFO - 'LOGNAME': 'cltbld', 10:13:36 INFO - 'MAIL': '/var/mail/cltbld', 10:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:36 INFO - 'MOZ_NO_REMOTE': '1', 10:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:36 INFO - 'NO_EM_RESTART': '1', 10:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:36 INFO - 'PWD': '/builds/slave/test', 10:13:36 INFO - 'SHELL': '/bin/bash', 10:13:36 INFO - 'SHLVL': '1', 10:13:36 INFO - 'TERM': 'linux', 10:13:36 INFO - 'TMOUT': '86400', 10:13:36 INFO - 'USER': 'cltbld', 10:13:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:36 INFO - '_': '/tools/buildbot/bin/python'} 10:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:36 INFO - Downloading/unpacking jsonschema 10:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:38 INFO - Downloading/unpacking functools32 (from jsonschema) 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:38 INFO - warning: no files found matching '*.txt' 10:13:38 INFO - no previously-included directories found matching 'build' 10:13:38 INFO - no previously-included directories found matching 'dist' 10:13:38 INFO - no previously-included directories found matching '.git*' 10:13:38 INFO - Installing collected packages: jsonschema, functools32 10:13:38 INFO - Running setup.py install for functools32 10:13:38 INFO - warning: no files found matching '*.txt' 10:13:38 INFO - no previously-included directories found matching 'build' 10:13:38 INFO - no previously-included directories found matching 'dist' 10:13:38 INFO - no previously-included directories found matching '.git*' 10:13:38 INFO - Successfully installed jsonschema functools32 10:13:38 INFO - Cleaning up... 10:13:38 INFO - Return code: 0 10:13:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1096cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x193d8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', '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 10:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:13:38 INFO - Using env: {'DISPLAY': ':0', 10:13:38 INFO - 'HOME': '/home/cltbld', 10:13:38 INFO - 'LANG': 'en_US.UTF-8', 10:13:38 INFO - 'LANGUAGE': 'en_US:en', 10:13:38 INFO - 'LOGNAME': 'cltbld', 10:13:38 INFO - 'MAIL': '/var/mail/cltbld', 10:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:38 INFO - 'MOZ_NO_REMOTE': '1', 10:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:38 INFO - 'NO_EM_RESTART': '1', 10:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:38 INFO - 'PWD': '/builds/slave/test', 10:13:38 INFO - 'SHELL': '/bin/bash', 10:13:38 INFO - 'SHLVL': '1', 10:13:38 INFO - 'TERM': 'linux', 10:13:38 INFO - 'TMOUT': '86400', 10:13:38 INFO - 'USER': 'cltbld', 10:13:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:38 INFO - '_': '/tools/buildbot/bin/python'} 10:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:38 INFO - Downloading/unpacking flake8 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:13:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:13:40 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 10:13:40 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 10:13:40 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 10:13:40 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 10:13:40 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 10:13:40 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 10:13:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:13:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:13:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:41 INFO - no previously-included directories found matching 'docs/_build' 10:13:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:13:41 INFO - Running setup.py install for pep8 10:13:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:13:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:13:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:13:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:13:41 INFO - no previously-included directories found matching 'docs/_build' 10:13:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:13:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:13:41 INFO - Cleaning up... 10:13:41 INFO - Return code: 0 10:13:41 INFO - Running post-action listener: _resource_record_post_action 10:13:41 INFO - Running post-action listener: _start_resource_monitoring 10:13:41 INFO - Starting resource monitoring. 10:13:41 INFO - ##### 10:13:41 INFO - ##### Finished create-virtualenv step (success) 10:13:41 INFO - ##### 10:13:41 INFO - ##### 10:13:41 INFO - ##### Running install step. 10:13:41 INFO - ##### 10:13:41 INFO - Running pre-action listener: _resource_record_pre_action 10:13:41 INFO - Running main action method: install 10:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:42 INFO - Reading from file tmpfile_stdout 10:13:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:42 INFO - Reading from file tmpfile_stdout 10:13:42 INFO - Output received: 10:13:42 INFO - Usage: mozinstall [options] installer 10:13:42 INFO - Options: 10:13:42 INFO - -h, --help show this help message and exit 10:13:42 INFO - -d DEST, --destination=DEST 10:13:42 INFO - Directory to install application into. [default: 10:13:42 INFO - "/builds/slave/test"] 10:13:42 INFO - --app=APP Application being installed. [default: firefox] 10:13:42 INFO - mkdir: /builds/slave/test/build/application 10:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:13:58 INFO - Reading from file tmpfile_stdout 10:13:58 INFO - Output received: 10:13:58 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:58 INFO - Running post-action listener: _resource_record_post_action 10:13:58 INFO - ##### 10:13:58 INFO - ##### Finished install step (success) 10:13:58 INFO - ##### 10:13:58 INFO - ##### 10:13:58 INFO - ##### Running run-tests step. 10:13:58 INFO - ##### 10:13:58 INFO - Running pre-action listener: _resource_record_pre_action 10:13:58 INFO - Running main action method: run_tests 10:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:58 INFO - Python 2.7.3 10:13:58 INFO - Return code: 0 10:13:58 INFO - grabbing minidump binary from tooltool 10:13: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')]} 10:13:58 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 0x19ccb20>, '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 0x19cda20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cdeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:58 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 10:13:58 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 10:13:58 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 10:13:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:59 INFO - Return code: 0 10:13:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:13:59 INFO - Return code: 0 10:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:13:59 INFO - Using env: {'DISPLAY': ':0', 10:13:59 INFO - 'HOME': '/home/cltbld', 10:13:59 INFO - 'LANG': 'en_US.UTF-8', 10:13:59 INFO - 'LANGUAGE': 'en_US:en', 10:13:59 INFO - 'LOGNAME': 'cltbld', 10:13:59 INFO - 'MAIL': '/var/mail/cltbld', 10:13:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:59 INFO - 'MOZ_NO_REMOTE': '1', 10:13:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:59 INFO - 'NO_EM_RESTART': '1', 10:13:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:59 INFO - 'PWD': '/builds/slave/test', 10:13:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:59 INFO - 'SHELL': '/bin/bash', 10:13:59 INFO - 'SHLVL': '1', 10:13:59 INFO - 'TERM': 'linux', 10:13:59 INFO - 'TMOUT': '86400', 10:13:59 INFO - 'USER': 'cltbld', 10:13:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214', 10:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:59 INFO - '_': '/tools/buildbot/bin/python'} 10:13:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:14:00 INFO - mozversion application_buildid: 20160601073118 10:14:00 INFO - mozversion application_changeset: 111970c738234569c8c180319155327316335deb 10:14:00 INFO - mozversion application_display_name: Nightly 10:14:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:00 INFO - mozversion application_name: Firefox 10:14:00 INFO - mozversion application_remotingname: firefox 10:14:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:14:00 INFO - mozversion application_vendor: Mozilla 10:14:00 INFO - mozversion application_version: 49.0a1 10:14:00 INFO - mozversion platform_buildid: 20160601073118 10:14:00 INFO - mozversion platform_changeset: 111970c738234569c8c180319155327316335deb 10:14:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:14:00 INFO - mozversion platform_version: 49.0a1 10:14:00 INFO - using testdate: 1464801240 10:14:00 INFO - actual date: 1464801240 10:14:00 INFO - starting webserver on 'localhost:35640' 10:14:00 INFO - SUITE-START | Running 2 tests 10:14:00 INFO - TEST-START | dromaeo_css 10:14:00 INFO - operating with platform_type : linux_ 10:14:00 INFO - Initialising browser for dromaeo_css test... 10:14:00 INFO - TEST-INFO | started process 29607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsC1uW/profile http://localhost:35640/getInfo.html) 10:14:04 INFO - PROCESS | 29607 | __metrics Screen width/height:1600/1200 10:14:04 INFO - PROCESS | 29607 | colorDepth:24 10:14:04 INFO - PROCESS | 29607 | Browser inner width/height: 1024/697 10:14:04 INFO - PROCESS | 29607 | __metrics 10:14:05 ERROR - PROCESS | 29607 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:14:06 INFO - TEST-INFO | 29607: exit 0 10:14:06 INFO - Browser initialized. 10:14:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:06 INFO - TEST-INFO | started process 29691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsC1uW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:18 INFO - PROCESS | 29691 | RSS: Main: 155430912 10:14:18 INFO - PROCESS | 29691 | 10:15:09 INFO - PROCESS | 29691 | 1464801309397 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] 10:17:17 INFO - PROCESS | 29691 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35640/tests/dromaeo/cssquery-ext.html) 10:17:18 INFO - PROCESS | 29691 | RSS: Main: 243412992 10:17:18 INFO - PROCESS | 29691 | 10:20:20 INFO - PROCESS | 29691 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-ext.html (next: http://localhost:35640/tests/dromaeo/cssquery-jquery.html) 10:20:21 INFO - PROCESS | 29691 | RSS: Main: 240275456 10:20:21 INFO - PROCESS | 29691 | 10:23:23 INFO - PROCESS | 29691 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35640/tests/dromaeo/cssquery-mootools.html) 10:23:23 INFO - PROCESS | 29691 | RSS: Main: 235737088 10:23:23 INFO - PROCESS | 29691 | 10:26:25 INFO - PROCESS | 29691 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35640/tests/dromaeo/cssquery-prototype.html) 10:26:26 INFO - PROCESS | 29691 | RSS: Main: 243429376 10:26:26 INFO - PROCESS | 29691 | 10:29:29 INFO - PROCESS | 29691 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35640/tests/dromaeo/cssquery-yui.html) 10:29:29 INFO - PROCESS | 29691 | RSS: Main: 219246592 10:29:29 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | Cycle 1(1): loaded http://localhost:35640/tests/dromaeo/cssquery-yui.html (next: http://localhost:35640/tests/dromaeo/cssquery-dojo.html) 10:32:32 INFO - PROCESS | 29691 | RSS: Main: 288407552 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | __start_tp_report 10:32:32 INFO - PROCESS | 29691 | _x_x_mozilla_page_load 10:32:32 INFO - PROCESS | 29691 | _x_x_mozilla_page_load_details 10:32:32 INFO - PROCESS | 29691 | |i|pagename|runs| 10:32:32 INFO - PROCESS | 29691 | |0;dojo.html;3105.347876945841;3120.344727607201;3136.2316232523035;3159.3839201355718;3186.458302088645;5279.762410691518;5319.787208511655;5387.676739395634;5483.533899618527;5485.561155107592;5362.35651721794;5365.7853685852615;5407.188921661753;5415.025295446818;5436.836894893149;4819.132556139884;4824.927626085611;4954.232094025432;5005.699658020512;5016.774245158958;4965.726885021322;4979.701217926936;4999.375078115236;5005.849824505271;5008.29883816266;4747.145513807513;4806.975965120169;4821.903561928777;4877.6341774367065;4929.457759646436;4893.363862697862;4900.852974410774;4904.141775189328;4965.081459929888;4969.155243608595;4871.182307516922;4886.022795440926;4887.29134275528;4891.388576427947;4891.584215341701;5160.354955630546;5274.997750427407;5346.8395948121615;5360.544353729938;5412.566994640459;5639.323281206241;5684.573656975702;5686.147077938343;5688.345840228385;5690.004249256363;5739.770409183628;5799.666076802359;5806.941930580682;5810.012297909366;5810.21562089121;5266.868328291824;5322.20166974953;5378.731063446812;5385.084535628953;5428.022955867942;5914.645121292736;5932.644041357532;5935.228420305332;5940.316863560746;5950;5670.5180059695385;5670.688112153789;5713.600047996683;5726.112452569859;5726.685032323179;5559.722013899289;5778.595498315078;5856.795012174553;5860;5887.146363777314;5839.0949402842625;5847.502962248172;5847.590668653239;5848.3274423441;5855.121731740188;5431.131019036935;5856.882862342814;5860.531157507389;5862.973979553561;5863.296404431496;4354.9782251088545;4391.429114215195;4392.516823149451;4401.977990110029;4402.031553058322;3915.432262322004;3919.3729003359326;3920.4903362562686;3939.0940083780893;3957.485526881487;5282.286891269706;5321.813736519203;5488.588355873326;5511.255980442589;5511.3937466878615;5704.916065947456;5752.338481074647;5753.453421924911;5755.712214389264;5768.596198266081;5426.810061647902;5448.155535891943;5453.318335208099;5455.863603409867;5464.699441530674;4866.6106711463;4933.753312334369;4941.431735350408;4955.82654607087;4985.850424487271;5940.821775346746;6029.306629737549;6032.215811944419;6040.909386359208;6090.025595904634;5838.065909454467;5845.386234445322;5847.5906686533235;5855.9121613176685;5858.7070646468355;5764;5829.213056237523;5859.179714840011;6007.279126504847;6022.698865056817;5641.6050876439895;5648.661080335193;5659.377468478547;5660.462256085665;5707.058335374617;5702.914456283076;5715.971420142872;5745.425457454221;5752.165935939349;5756.280464941882;5482.835514934558;5576.581756368208;5598.496135347838;5604.299462567179;5631.070873306023;5652.378238393856;5663.150527420755;5671.291088613923;5677.233573467529;5678.4605462480995;5540.085885828793;5553.250311207935;5565.860853478695;5572.247746554163;5573.359063707563;5539.362973257966;5559.58303127259;5611.775528978795;5622.072358061037;5716.79991200306;5527.474889885454;5532.0595498766115;5535.916961245504;5540.196671482532;5583.190437386637 10:32:32 INFO - PROCESS | 29691 | |1;ext.html;590.7755053079829;614.5268143529482;615.2063837649432;640.2445114764582;642.781454305536;31315.843420782894;43696.34455483167;44399;44635.107297854025;44708.77645611772;42424.787876060574;42844.785776071076;42847.14305713884;42874.14251714964;42874.785626071825;8752.693655722034;8940.418872773282;8947.373683842134;8950.060243674418;8950.641974321019;8561.0582835888;8643.740687779376;8657.393982421234;8658.134186581323;8672.826543469128;8908.331875109361;8971.14774096463;8986.775330616754;8990.325725570576;8998.955005224965;8859.689910853122;8861.335399844973;8870.201681848632;8924.553772311423;8925.821483570324;8759.51822649754;8881.86677199836;8887.333449991213;8893.510856902867;8896.555172241362;42414;42441.78779106116;42938.355924661155;42967.78516107431;43017.35473967893;3463.2380876207194;3556.1643013891717;3619.6199399062984;3715.758475699071;4010.057636455431;32372;32904.34191316184;32970.50544241838;33034.6696533034;34430.655693443;4312.82748690052;4333.566643335673;4341.869743907688;4347.304671103904;4352.586504282088;344922;345029;346063;346138;350134;56520.43479565152;56758.432415675314;57364.71317643385;57447.71276143593;57461.425385745606;60489.69755151196;60569.69715151396;60679;60726.08910866341;60756;15590.844091559165;16287.918560407123;16290;16660.666786664442;16739;12724.491020359266;12876.098673092982;12887.420066097047;12893.290869002107;12915.16051456671;15825.287862046236;16004.75992860108;16048.27782749779;16116.355345786038;16120.596985075232;5010.624203184776;5708.20085188074;5718.857028574235;5918.112283157561;5939.227900372924;976.2336565795958;1063.6330465989222;1077.0898590690854;1156.19066653343;1187.89902858258;32170.839145804588;32224;32549.51175732366;32680.673193268238;32854.67145328564;1069.9518521666544;1079.2876701377054;1162.3200427749691;1165.1785491228663;1205.9397030148457;16615.6676866462;17178.1410929453;17202;17278.481645550655;17461.912690436468;585322;588310;590618;591066;594741;56802.715986419804;57363;57538;57684;57745.711271443375;1247.2267194339568;1377.9517716879861;1378.9448422063006;1379.544750232421;1390.1033833177544;32184.678153218167;33386.49920251247;33472.66527334793;33677.48696324837;34032.31935361229;48806;48917.51082489272;49227.50772492372;49266.75366623144;49395.50604493909;426339;427328;429768;429786;429954;33795.3240935175;34282.14294642654;44442.55557444384;45038.77480612707;45274.54725452835;48081.78015593235;48258.758706206245;48345.5165448341;48980;49814.750926245135;40397.59602403938;40417.59582404138;40795.92606563542;41047.794761026;41924.580754192066;40115.598844012355;40510;40848.59151408448;40960.38559421551;41550.1689966205;39546.60453395429;40435;40596.18807623772;40739.38890916579;40798.38802417907;32353.676463235068;35476.46785298274;35663;35901.28197436089;36283.818580906925;27768;28184.29539261535;28234.576481353208;28245.435091297648;28262 10:32:32 INFO - PROCESS | 29691 | |2;jquery.html;385.33337326425266;388.46004054364437;394.4536816509135;397.8508059477696;408.93252613318805;17730.556736081588;19372.321968731096;19732.112054957524;19736.210551577937;19745.11146998385;18290.268389264413;18580.721289180674;18790.248390064415;18945.62108757824;18972.146253418596;5538.501534861862;5602.691851948141;5695.288088988877;5703.230063941356;5728.656280623176;5498.5876059295715;5598.832035038935;5607;5623.0721930881355;5626.634268772537;5441.5102640762325;5513.228148059255;5585.58108141889;5585.804496842611;5594.412586678402;5553;5566.86082847928;5577.749001294931;5582.8325150245555;5590.664560126405;4882.267659851015;4935.5436430475365;4970.900581988376;4987.977464619744;4996.725180115092;22518.32445026652;22564.097436102536;22741.658875116886;22908.656370154462;23024.194153204557;2402.8798560071928;2438.6098224284206;2644.9684622997047;2707.7969152313653;2770.127409865886;13767.242801645905;14056.367463464168;14307.427702891871;14359.497417590439;14362.712745745132;1901.5436295289169;1917.1756144857707;1922.3464022232508;1941.3108346536917;2013.5167559785693;76635.23364766393;77170.61414692947;77606.61196694037;78195.60902195453;79227.20772792256;9683.41899486033;9689.467079310565;9797.31418800677;10104.938981406993;10121.898781012096;13228.603141905758;13379.331033448289;13380.531681391105;13387.330633468287;13426;7911.643976021093;8018.959905200553;8169.5098294102545;8215.917840821634;8301.335893128535;8084.191580841869;8217.808417779388;8273.751787446387;8361.498310101413;8367.079621241659;6169.413905678954;6317.3366796486625;6374.649394283359;6438.130852334969;6505.512086593524;1769.9292028318723;1789.2753434858903;1801.3064969986387;1809.4028970439724;1844.492764489776;1016.2987538598344;1016.832222683249;1026.4662375564815;1048.528162326956;1084.1110289562641;18139.72790408145;18541;19058.904705476383;19729.112189951487;19806.90096549537;1051.30613794895;1052.847337136111;1064.2497039587226;1071.464267866067;1083.8861919498497;11184.161187910939;11388.088952883749;11464.140189485823;11471.139664525028;11482.253653512495;480878;484780;494587;495442;506274;57264;74321.6283918577;77576;82078.17921820824;83674.58162709269;1048.4810019040624;1051.3324039234988;1054.6414219165367;1089.1504626391427;1094.0372472224392;13831.585052448443;16575.171241437638;17172.141392930553;17754.20106095203;17790.377336793666;29614.55578166286;36233.81883090568;41871.7906410466;42250.788746056074;42852.78573607112;55318.72340638271;56584;58045.419545804005;58618.4138158613;58905.70547147237;7688.923110768821;8605.612747426256;8889.555522223734;8967.955160224157;9050.637974480947;13039.869601303866;13451.46194152223;13920.303984800517;13928.72142557123;14083.507077252247;12121.75756484883;12130.393480325773;12173.087018473827;12194.939025304817;12296.446659900146;11801.645950621494;11818.763624727286;11898.464569094585;12061.819072714092;12169.817452738393;12084.818727718915;12383.257004579755;12531.122821402414;12540;12590.411732656148;7720;7919.336939242824;8026.719064832703;8133.186681331819;8456.2812160967;10829.999157159977;11993.220440671328;12125.75748485043;12185.512579497075;12405.131640785059 10:32:32 INFO - PROCESS | 29691 | |3;mootools.html;1300.2848433361648;1462.2615579132537;1503.7969874067;1601.5195441367587;1739.4433781190016;7979.601019949001;8324.375671824615;8339.33285337173;8590.098039705834;8611.741647750561;8414.116517765638;8582.699605513808;8587.78530536737;8589.570521473932;8600.053994060649;2018.777934427212;2282.1441959265276;2283.931482055533;2322.442613772691;2354.540864531417;2326.499802542453;2332.6384410416413;2336.6261398176293;2337.4273303040777;2339.894704738282;2270.6594010898334;2306.2850516339904;2309.6997390339234;2311.503026849227;2312.9421764455938;2029.168041103148;2249.2352600115873;2319.5940710375785;2325.9069637214493;2336.801371883375;2240.238318971541;2244.539869326784;2245.921392751246;2247.314569056437;2297.574948634508;8382.329413646894;8438.704645337446;8444.873326900102;8453.196946290092;8456.154384561556;5052.494750524955;5224.190250511177;5225.059489291926;5226.947730522684;5227.137522308814;3194.3132226571397;3308.983455082733;3362.3107263011025;3409.6931276185264;3411.675890790371;1106.4633652678444;1121.1255220927608;1143.0741099709178;1182.7516221593476;1190.5297407523979;11659.708507287301;11665.358405287705;11665.416729163593;11679.065674746;11704.648860534198;4450.065486247924;4579.6794224403975;4612.400387949545;4657.836975705834;4659.4175728034;9741.366811157252;9786;9787.412755234709;9788.951055244679;9792.21662267017;4458.219811532968;5156.1492353761205;5183.714895680699;5199.142141546678;5204.297419848272;4180.540140584533;4247.830086796555;4251.936220956688;4655.208614535537;4770.189067858403;3822.503074600284;3880.7283490155983;3975.940360894589;3994.8202330894596;4061.7766022868436;1250.93745312734;1258.4955937684126;1270.2632473165543;1275.483429211171;1277.4123903004722;930.4742820306506;940.6519587752439;941.5245301122889;943.9669611563562;970.6990832841842;5490.16079613334;5652.74562644682;5711.371749107595;5769.105788602773;5881.529477641779;420.74124413485487;433.44735462285837;437.63457512976385;439.18750311922685;445.57670213297496;3811.123441608446;3883.8834834954996;3890.7081968851885;3894.2600905827803;3942.48747662802;10118.190544756402;10444.477776111164;10479.056884880245;10501.474926253657;10519.737006574744;10157.441340726331;10263.692089237335;10327.586896524204;10350.016748408889;10374.22193335503;7740.225977402328;7886.566238856918;7902.841943161219;7922.643481043367;7977.441579089524;5512.972435137799;5520.1167813149705;5550.833474995757;5558.583106267127;5562.22128901946;9670.903290967282;9797.608095676092;9843.950780246052;9917.752056198653;9922.702318930444;9331.300152488726;9630.518474076409;9669.564869580745;9945.30382873192;9968.950155249177;6647;6850.143732033496;6850.794476165723;7402.6668799903055;7632.1604623492485;7678.731244406419;7836.216378362118;7895.526268423913;8095.23095305945;8133.0646975598565;7268.309510596485;7348.963255183904;7424.1462231844025;7427;7579.772606821804;7255.680126996768;7310;7329.853402931805;7360.742374016883;7431.962840185981;6773.966130169318;6782;6832.692528836114;6836.316368363124;6839.794806155824;4658.8136474542;4762.666613337033;4770.379850619397;4778.976105119452;4830.613550915848;4746.33551302811;4803.327534145293;4870.172070747911;4875.68308059975;4986.376702912136 10:32:32 INFO - PROCESS | 29691 | |4;prototype.html;333.92486690494644;334.3079824762742;341.1641478377975;342.0320493004797;344.24953601149485;5376.327959005124;5380.435054319299;5389.8113566025195;5392.811251606195;5395.271638328824;5260.237265596486;5269.340157850274;5316.6544174628625;5336.466353364662;5341.412444631087;3896.8441262349615;3980.2039592081555;4054.128362402083;4084.9387259191135;4136.503619565657;4071.4707088078508;4131.504219493665;4135.27632664284;4166.812493437787;4172.395002724603;4093.2018256440006;4112.095339025424;4117.702923579078;4122.113745544707;4123.154753275587;3890.7860067696124;4031.737937034083;4113.25961326961;4114.691398145121;4138.234426631083;3588.5334906462253;3628.983884512341;3632.8365223565;3636.7454278200535;3642.417213245868;5077.060743762416;5081.339425874649;5090.236464530313;5128.179491281415;5159.638825282232;4512.864614061584;4698.95301046992;4736.194846876005;4739.464386553177;4750.836045168921;5492.835214943558;5527.309086364205;5529.253550770634;5534.335879694422;5558.249636299089;3947.4868267125375;3984.4222587724907;3987.501562304712;3990.900227494336;4001.679865610744;5450.645708028966;5703.173039909231;5740.684262365568;5789.739461724233;5790.160426738142;3967.8214480347874;3970.305196590585;3997.980010099931;4016.196760647882;4023.255697695877;4028.4158796974275;4033.1328764315813;4068.4507591475362;4095.774732389747;4101.2207680540605;4537.977310113428;4649.418822647169;4709.95290047102;4726.125666751662;4728.692634978715;5494.890102197934;5513.972430137824;5525.834224973257;5537.473939975695;5555.611107222537;1404.2346920928119;1415.8725714685727;1422.3101795629111;1433.2332202271944;1436.3608194353412;886.1120116314415;898.3038145437338;903.9276857851356;905.4069584422214;924.9398789078689;5266.657667251617;5354.705491198021;5357.517823395913;5363.919541206885;5420.159875219348;5688.573356998241;5707.429257074343;5707.600467967202;5746.195532625436;5753.654780713171;5241.514943830323;5314.601404894648;5378.655336165959;5404.162354835007;5458.208559758813;3014.156036309837;3022.637283525991;3022.667506574319;3033.014270362141;3043.102284825937;5845.515655846249;5873.236479257669;5875.618084824473;5937.079752638348;5970.611910225822;5598.720063996784;5744.684042377709;5795.391483894215;5823.82528524145;5835;5849.298084229835;5859.861150679971;5909.852253693606;5943.989521781394;5958.19564358806;5380.973095134499;5644.85887852807;5681.744321505625;5772.682502462405;5794.82615521535;5586.994341018656;5685.379666794944;5726.713664316684;5732.168835518743;5747.36778954323;5936.732847021808;5956.821295361146;5958.19564358806;5995.081573896311;5996.340402555628;4003.8798836034966;4113.5886411359825;4137.834486620502;4144.772037537964;4145.859888530557;5758.740856661377;5779.3590038275615;5803.187553742564;5826.41735826414;5845.444682755132;5439;5588.6646801192055;5614.522765564972;5647.548196144381;5655.406182350794;5559;5560.499555040065;5569.053260945568;5629.802956896489;5646.237757902631;5267.444474979297;5464.890702185855;5514.503694667499;5522.66863988162;5543.972280138735;5457.508824205841;5620.3536593290655;5633.155026746021;5639.6334238274385;5671.347795003628;5469.507744303032;5475.330024342614;5486.478784515464;5528.170774383874;5540.806071787468 10:32:32 INFO - PROCESS | 29691 | |5;yui.html;800.0958916424441;836.0510820219049;847.4576271186438;852.3011130872683;867.2844902955068;12701.618951431461;14339.498117565887;14430.927845360784;14499.855001449982;14557.70884582309;13901.443942242324;14387.71224575508;14933.253337333144;14961.102333859948;15548.45580404686;676.3236763236763;810.2909953790448;812.7521106062649;817.2032268538187;817.284875733733;687.9208890977527;698.6471831724972;698.6751160710294;791.9881201781977;817.9591020448984;858.0347109501811;859.1108203009886;860.777695672144;861.5692153923038;862.2713806833216;854.7435769269257;856.6830272799042;856.7943693513542;857.2327766648846;857.4469467193625;521.1063026908831;610.1092405088576;623;624.0420953835885;629.8834715577633;14640.487582934546;14651.267436628126;14653.853461465356;14654.560363189015;14659.780103298459;12682.873171268353;13465.124766890121;13584.796228056586;13593.116447430984;13700.314984250846;12506.249625022529;12513.124081314312;12791.296478693668;12880.162789418659;13265.005124615693;4363.912721745547;4393.912121757547;4423.358613001129;4520.977395113036;4521.615662668677;58257;59061.40938590602;59311;60103;61270.38729612736;11010.39442830652;11104.777904441866;11135.498902549405;11151.721206969729;11333.886661133449;19536.804631953783;19544.70682939757;19563.706544401844;19566.70649940252;19584.118714657874;8153.063349897408;8240.527841647601;8399.538025408661;8410.411271210956;8505.659773608986;4735.431748190171;4757.881052973634;4775.856724298276;4786.593139583105;4922.08941345845;3269.0683155300626;3364.5457863188644;3375.7130643895052;3377.4089534331392;3377.7973321600293;611.6819253987901;630.2405601250482;638.8434833465831;641.371455973149;657.5857209957696;612.6599737145838;660.7819419591523;702.0978043214445;718.5437247347971;727.1238158019573;9004.099590040943;9073.410228335137;9190.022603324114;9229;9291.442513449214;706.9964650176819;711.573056166296;733.7908696021608;734.5152199548272;738.9002484664502;4058.776767277828;4130.235906357333;4194.6853985951175;4207.305794543927;4302.333138363559;67157;68450.65774671095;68706.65646671735;69251.30748692449;69479.65260173767;59993.40006599965;60235.39764602298;60585;61762.38237617656;61984.380156198764;51153.48846511562;51448.74275628673;52226.73886630542;52465.47534524606;52813.47186528162;8489;8560.700375486827;8608.956955215184;8746.737597872074;8799.736007919773;37087.81456092702;37527.24945501129;37736.245275094894;38381.424278636405;38567.614323857524;46913.296300556205;48679.5132048675;51202;51430.48569514257;52045;11107.777844443228;11196.913116767706;11215.158863085138;11387.715307117389;11833.290002599872;12254.38728063611;12418.379081046092;12466.688332791753;12480.5007799687;12717.427715752998;10130.430472485943;12952.481900724242;13162.934185329012;13267.469301227842;13513;13292.468301267842;13343.466261349826;13360.465581377024;13526.79709804334;13646.385912634154;12737.617871463872;12771.489140434278;12791.168574042658;12831.743365132459;12981.740365192833;10964.396958167377;11097.223194376316;11278.548858045586;11451.141164412536;11462.598809041643;11315.547378105113;11472.88527114718;11498.94250528742;11525.193236473366;11574.479148438171 10:32:32 INFO - PROCESS | 29691 | __end_tp_report 10:32:32 INFO - PROCESS | 29691 | __start_cc_report 10:32:32 INFO - PROCESS | 29691 | _x_x_mozilla_cycle_collect,981 10:32:32 INFO - PROCESS | 29691 | __end_cc_report 10:32:32 INFO - PROCESS | 29691 | __startTimestamp1464802352703__endTimestamp 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | ------- Summary: start ------- 10:32:32 INFO - PROCESS | 29691 | Number of tests: 6 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | [#0] dojo.html Cycles:165 Average:5354.17 Median:5540.20 stddev:609.63 (11.0%) stddev-sans-first:585.42 10:32:32 INFO - PROCESS | 29691 | Values: 3105.3 3120.3 3136.2 3159.4 3186.5 5279.8 5319.8 5387.7 5483.5 5485.6 5362.4 5365.8 5407.2 5415.0 5436.8 4819.1 4824.9 4954.2 5005.7 5016.8 4965.7 4979.7 4999.4 5005.8 5008.3 4747.1 4807.0 4821.9 4877.6 4929.5 4893.4 4900.9 4904.1 4965.1 4969.2 4871.2 4886.0 4887.3 4891.4 4891.6 5160.4 5275.0 5346.8 5360.5 5412.6 5639.3 5684.6 5686.1 5688.3 5690.0 5739.8 5799.7 5806.9 5810.0 5810.2 5266.9 5322.2 5378.7 5385.1 5428.0 5914.6 5932.6 5935.2 5940.3 5950.0 5670.5 5670.7 5713.6 5726.1 5726.7 5559.7 5778.6 5856.8 5860.0 5887.1 5839.1 5847.5 5847.6 5848.3 5855.1 5431.1 5856.9 5860.5 5863.0 5863.3 4355.0 4391.4 4392.5 4402.0 4402.0 3915.4 3919.4 3920.5 3939.1 3957.5 5282.3 5321.8 5488.6 5511.3 5511.4 5704.9 5752.3 5753.5 5755.7 5768.6 5426.8 5448.2 5453.3 5455.9 5464.7 4866.6 4933.8 4941.4 4955.8 4985.9 5940.8 6029.3 6032.2 6040.9 6090.0 5838.1 5845.4 5847.6 5855.9 5858.7 5764.0 5829.2 5859.2 6007.3 6022.7 5641.6 5648.7 5659.4 5660.5 5707.1 5702.9 5716.0 5745.4 5752.2 5756.3 5482.8 5576.6 5598.5 5604.3 5631.1 5652.4 5663.2 5671.3 5677.2 5678.5 5540.1 5553.3 5565.9 5572.2 5573.4 5539.4 5559.6 5611.8 5622.1 5716.8 5527.5 5532.1 5535.9 5540.2 5583.2 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | [#1] ext.html Cycles:180 Average:61523.28 Median:426833.50 stddev:123887.59 (29.0%) stddev-sans-first:124150.66 10:32:32 INFO - PROCESS | 29691 | Values: 590.8 614.5 615.2 640.2 642.8 31315.8 43696.3 44399.0 44635.1 44708.8 42424.8 42844.8 42847.1 42874.1 42874.8 8752.7 8940.4 8947.4 8950.1 8950.6 8561.1 8643.7 8657.4 8658.1 8672.8 8908.3 8971.1 8986.8 8990.3 8999.0 8859.7 8861.3 8870.2 8924.6 8925.8 8759.5 8881.9 8887.3 8893.5 8896.6 42414.0 42441.8 42938.4 42967.8 43017.4 3463.2 3556.2 3619.6 3715.8 4010.1 32372.0 32904.3 32970.5 33034.7 34430.7 4312.8 4333.6 4341.9 4347.3 4352.6 344922.0 345029.0 346063.0 346138.0 350134.0 56520.4 56758.4 57364.7 57447.7 57461.4 60489.7 60569.7 60679.0 60726.1 60756.0 15590.8 16287.9 16290.0 16660.7 16739.0 12724.5 12876.1 12887.4 12893.3 12915.2 15825.3 16004.8 16048.3 16116.4 16120.6 5010.6 5708.2 5718.9 5918.1 5939.2 976.2 1063.6 1077.1 1156.2 1187.9 32170.8 32224.0 32549.5 32680.7 32854.7 1070.0 1079.3 1162.3 1165.2 1205.9 16615.7 17178.1 17202.0 17278.5 17461.9 585322.0 588310.0 590618.0 591066.0 594741.0 56802.7 57363.0 57538.0 57684.0 57745.7 1247.2 1378.0 1378.9 1379.5 1390.1 32184.7 33386.5 33472.7 33677.5 34032.3 48806.0 48917.5 49227.5 49266.8 49395.5 426339.0 427328.0 429768.0 429786.0 429954.0 33795.3 34282.1 44442.6 45038.8 45274.5 48081.8 48258.8 48345.5 48980.0 49814.8 40397.6 40417.6 40795.9 41047.8 41924.6 40115.6 40510.0 40848.6 40960.4 41550.2 39546.6 40435.0 40596.2 40739.4 40798.4 32353.7 35476.5 35663.0 35901.3 36283.8 27768.0 28184.3 28234.6 28245.4 28262.0 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | [#2] jquery.html Cycles:180 Average:28478.53 Median:22966.43 stddev:80788.46 (351.8%) stddev-sans-first:80987.56 10:32:32 INFO - PROCESS | 29691 | Values: 385.3 388.5 394.5 397.9 408.9 17730.6 19372.3 19732.1 19736.2 19745.1 18290.3 18580.7 18790.2 18945.6 18972.1 5538.5 5602.7 5695.3 5703.2 5728.7 5498.6 5598.8 5607.0 5623.1 5626.6 5441.5 5513.2 5585.6 5585.8 5594.4 5553.0 5566.9 5577.7 5582.8 5590.7 4882.3 4935.5 4970.9 4988.0 4996.7 22518.3 22564.1 22741.7 22908.7 23024.2 2402.9 2438.6 2645.0 2707.8 2770.1 13767.2 14056.4 14307.4 14359.5 14362.7 1901.5 1917.2 1922.3 1941.3 2013.5 76635.2 77170.6 77606.6 78195.6 79227.2 9683.4 9689.5 9797.3 10104.9 10121.9 13228.6 13379.3 13380.5 13387.3 13426.0 7911.6 8019.0 8169.5 8215.9 8301.3 8084.2 8217.8 8273.8 8361.5 8367.1 6169.4 6317.3 6374.6 6438.1 6505.5 1769.9 1789.3 1801.3 1809.4 1844.5 1016.3 1016.8 1026.5 1048.5 1084.1 18139.7 18541.0 19058.9 19729.1 19806.9 1051.3 1052.8 1064.2 1071.5 1083.9 11184.2 11388.1 11464.1 11471.1 11482.3 480878.0 484780.0 494587.0 495442.0 506274.0 57264.0 74321.6 77576.0 82078.2 83674.6 1048.5 1051.3 1054.6 1089.2 1094.0 13831.6 16575.2 17172.1 17754.2 17790.4 29614.6 36233.8 41871.8 42250.8 42852.8 55318.7 56584.0 58045.4 58618.4 58905.7 7688.9 8605.6 8889.6 8968.0 9050.6 13039.9 13451.5 13920.3 13928.7 14083.5 12121.8 12130.4 12173.1 12194.9 12296.4 11801.6 11818.8 11898.5 12061.8 12169.8 12084.8 12383.3 12531.1 12540.0 12590.4 7720.0 7919.3 8026.7 8133.2 8456.3 10830.0 11993.2 12125.8 12185.5 12405.1 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | [#3] mootools.html Cycles:180 Average:5541.57 Median:4791.15 stddev:3142.35 (65.6%) stddev-sans-first:3135.00 10:32:32 INFO - PROCESS | 29691 | Values: 1300.3 1462.3 1503.8 1601.5 1739.4 7979.6 8324.4 8339.3 8590.1 8611.7 8414.1 8582.7 8587.8 8589.6 8600.1 2018.8 2282.1 2283.9 2322.4 2354.5 2326.5 2332.6 2336.6 2337.4 2339.9 2270.7 2306.3 2309.7 2311.5 2312.9 2029.2 2249.2 2319.6 2325.9 2336.8 2240.2 2244.5 2245.9 2247.3 2297.6 8382.3 8438.7 8444.9 8453.2 8456.2 5052.5 5224.2 5225.1 5226.9 5227.1 3194.3 3309.0 3362.3 3409.7 3411.7 1106.5 1121.1 1143.1 1182.8 1190.5 11659.7 11665.4 11665.4 11679.1 11704.6 4450.1 4579.7 4612.4 4657.8 4659.4 9741.4 9786.0 9787.4 9789.0 9792.2 4458.2 5156.1 5183.7 5199.1 5204.3 4180.5 4247.8 4251.9 4655.2 4770.2 3822.5 3880.7 3975.9 3994.8 4061.8 1250.9 1258.5 1270.3 1275.5 1277.4 930.5 940.7 941.5 944.0 970.7 5490.2 5652.7 5711.4 5769.1 5881.5 420.7 433.4 437.6 439.2 445.6 3811.1 3883.9 3890.7 3894.3 3942.5 10118.2 10444.5 10479.1 10501.5 10519.7 10157.4 10263.7 10327.6 10350.0 10374.2 7740.2 7886.6 7902.8 7922.6 7977.4 5513.0 5520.1 5550.8 5558.6 5562.2 9670.9 9797.6 9844.0 9917.8 9922.7 9331.3 9630.5 9669.6 9945.3 9969.0 6647.0 6850.1 6850.8 7402.7 7632.2 7678.7 7836.2 7895.5 8095.2 8133.1 7268.3 7349.0 7424.1 7427.0 7579.8 7255.7 7310.0 7329.9 7360.7 7432.0 6774.0 6782.0 6832.7 6836.3 6839.8 4658.8 4762.7 4770.4 4779.0 4830.6 4746.3 4803.3 4870.2 4875.7 4986.4 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | [#4] prototype.html Cycles:180 Average:4682.83 Median:5385.39 stddev:1389.91 (25.8%) stddev-sans-first:1354.94 10:32:32 INFO - PROCESS | 29691 | Values: 333.9 334.3 341.2 342.0 344.2 5376.3 5380.4 5389.8 5392.8 5395.3 5260.2 5269.3 5316.7 5336.5 5341.4 3896.8 3980.2 4054.1 4084.9 4136.5 4071.5 4131.5 4135.3 4166.8 4172.4 4093.2 4112.1 4117.7 4122.1 4123.2 3890.8 4031.7 4113.3 4114.7 4138.2 3588.5 3629.0 3632.8 3636.7 3642.4 5077.1 5081.3 5090.2 5128.2 5159.6 4512.9 4699.0 4736.2 4739.5 4750.8 5492.8 5527.3 5529.3 5534.3 5558.2 3947.5 3984.4 3987.5 3990.9 4001.7 5450.6 5703.2 5740.7 5789.7 5790.2 3967.8 3970.3 3998.0 4016.2 4023.3 4028.4 4033.1 4068.5 4095.8 4101.2 4538.0 4649.4 4710.0 4726.1 4728.7 5494.9 5514.0 5525.8 5537.5 5555.6 1404.2 1415.9 1422.3 1433.2 1436.4 886.1 898.3 903.9 905.4 924.9 5266.7 5354.7 5357.5 5363.9 5420.2 5688.6 5707.4 5707.6 5746.2 5753.7 5241.5 5314.6 5378.7 5404.2 5458.2 3014.2 3022.6 3022.7 3033.0 3043.1 5845.5 5873.2 5875.6 5937.1 5970.6 5598.7 5744.7 5795.4 5823.8 5835.0 5849.3 5859.9 5909.9 5944.0 5958.2 5381.0 5644.9 5681.7 5772.7 5794.8 5587.0 5685.4 5726.7 5732.2 5747.4 5936.7 5956.8 5958.2 5995.1 5996.3 4003.9 4113.6 4137.8 4144.8 4145.9 5758.7 5779.4 5803.2 5826.4 5845.4 5439.0 5588.7 5614.5 5647.5 5655.4 5559.0 5560.5 5569.1 5629.8 5646.2 5267.4 5464.9 5514.5 5522.7 5544.0 5457.5 5620.4 5633.2 5639.6 5671.3 5469.5 5475.3 5486.5 5528.2 5540.8 10:32:32 INFO - PROCESS | 29691 | 10:32:32 INFO - PROCESS | 29691 | [#5] yui.html Cycles:180 Average:15680.92 Median:25824.36 stddev:18763.88 (72.7%) stddev-sans-first:18783.24 10:32:32 INFO - PROCESS | 29691 | Values: 800.1 836.1 847.5 852.3 867.3 12701.6 14339.5 14430.9 14499.9 14557.7 13901.4 14387.7 14933.3 14961.1 15548.5 676.3 810.3 812.8 817.2 817.3 687.9 698.6 698.7 792.0 818.0 858.0 859.1 860.8 861.6 862.3 854.7 856.7 856.8 857.2 857.4 521.1 610.1 623.0 624.0 629.9 14640.5 14651.3 14653.9 14654.6 14659.8 12682.9 13465.1 13584.8 13593.1 13700.3 12506.2 12513.1 12791.3 12880.2 13265.0 4363.9 4393.9 4423.4 4521.0 4521.6 58257.0 59061.4 59311.0 60103.0 61270.4 11010.4 11104.8 11135.5 11151.7 11333.9 19536.8 19544.7 19563.7 19566.7 19584.1 8153.1 8240.5 8399.5 8410.4 8505.7 4735.4 4757.9 4775.9 4786.6 4922.1 3269.1 3364.5 3375.7 3377.4 3377.8 611.7 630.2 638.8 641.4 657.6 612.7 660.8 702.1 718.5 727.1 9004.1 9073.4 9190.0 9229.0 9291.4 707.0 711.6 733.8 734.5 738.9 4058.8 4130.2 4194.7 4207.3 4302.3 67157.0 68450.7 68706.7 69251.3 69479.7 59993.4 60235.4 60585.0 61762.4 61984.4 51153.5 51448.7 52226.7 52465.5 52813.5 8489.0 8560.7 8609.0 8746.7 8799.7 37087.8 37527.2 37736.2 38381.4 38567.6 46913.3 48679.5 51202.0 51430.5 52045.0 11107.8 11196.9 11215.2 11387.7 11833.3 12254.4 12418.4 12466.7 12480.5 12717.4 10130.4 12952.5 13162.9 13267.5 13513.0 13292.5 13343.5 13360.5 13526.8 13646.4 12737.6 12771.5 12791.2 12831.7 12981.7 10964.4 11097.2 11278.5 11451.1 11462.6 11315.5 11472.9 11498.9 11525.2 11574.5 10:32:32 INFO - PROCESS | 29691 | -------- Summary: end -------- 10:32:32 INFO - PROCESS | 29691 | 10:32:33 INFO - TEST-INFO | 29691: exit 0 10:32:33 INFO - TEST-OK | dromaeo_css | took 1113296ms 10:32:33 INFO - TEST-START | kraken 10:32:33 INFO - operating with platform_type : linux_ 10:32:33 INFO - Initialising browser for kraken test... 10:32:33 INFO - TEST-INFO | started process 29873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzXU23/profile http://localhost:35640/getInfo.html) 10:32:37 INFO - PROCESS | 29873 | __metrics Screen width/height:1600/1200 10:32:37 INFO - PROCESS | 29873 | colorDepth:24 10:32:37 INFO - PROCESS | 29873 | Browser inner width/height: 1024/697 10:32:37 INFO - PROCESS | 29873 | __metrics 10:32:38 ERROR - PROCESS | 29873 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:32:39 INFO - TEST-INFO | 29873: exit 0 10:32:39 INFO - Browser initialized. 10:32:39 INFO - Running cycle 1/1 for kraken test... 10:32:39 INFO - TEST-INFO | started process 29954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVzXU23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:51 INFO - PROCESS | 29954 | RSS: Main: 155566080 10:32:51 INFO - PROCESS | 29954 | 10:32:53 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:54 INFO - PROCESS | 29954 | RSS: Main: 213614592 10:32:54 INFO - PROCESS | 29954 | 10:32:57 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-dft) 10:32:57 INFO - PROCESS | 29954 | RSS: Main: 197627904 10:32:57 INFO - PROCESS | 29954 | 10:33:00 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-fft) 10:33:01 INFO - PROCESS | 29954 | RSS: Main: 268775424 10:33:01 INFO - PROCESS | 29954 | 10:33:03 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35640/tests/kraken/driver.html?testName=audio-oscillator) 10:33:04 INFO - PROCESS | 29954 | RSS: Main: 179519488 10:33:04 INFO - PROCESS | 29954 | 10:33:06 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35640/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:06 INFO - PROCESS | 29954 | RSS: Main: 183644160 10:33:06 INFO - PROCESS | 29954 | 10:33:10 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35640/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:10 INFO - PROCESS | 29954 | RSS: Main: 218238976 10:33:10 INFO - PROCESS | 29954 | 10:33:14 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35640/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:14 INFO - PROCESS | 29954 | RSS: Main: 220217344 10:33:14 INFO - PROCESS | 29954 | 10:33:17 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35640/tests/kraken/driver.html?testName=json-parse-financial) 10:33:18 INFO - PROCESS | 29954 | RSS: Main: 220471296 10:33:18 INFO - PROCESS | 29954 | 10:33:19 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35640/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:20 INFO - PROCESS | 29954 | RSS: Main: 208715776 10:33:20 INFO - PROCESS | 29954 | 10:33:21 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:22 INFO - PROCESS | 29954 | RSS: Main: 211312640 10:33:22 INFO - PROCESS | 29954 | 10:33:24 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:25 INFO - PROCESS | 29954 | RSS: Main: 218861568 10:33:25 INFO - PROCESS | 29954 | 10:33:27 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:28 INFO - PROCESS | 29954 | RSS: Main: 222519296 10:33:28 INFO - PROCESS | 29954 | 10:33:31 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:31 INFO - PROCESS | 29954 | RSS: Main: 223502336 10:33:31 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | Cycle 1(1): loaded http://localhost:35640/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35640/tests/kraken/driver.html?testName=ai-astar) 10:33:33 INFO - PROCESS | 29954 | RSS: Main: 265621504 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | __start_tp_report 10:33:33 INFO - PROCESS | 29954 | _x_x_mozilla_page_load 10:33:33 INFO - PROCESS | 29954 | _x_x_mozilla_page_load_details 10:33:33 INFO - PROCESS | 29954 | |i|pagename|runs| 10:33:33 INFO - PROCESS | 29954 | |0;ai-astar;109;104;111;109;113;110;110;109;109;111 10:33:33 INFO - PROCESS | 29954 | |1;audio-beat-detection;149;124;136;175;126;127;154;125;155;124 10:33:33 INFO - PROCESS | 29954 | |2;audio-dft;162;160;160;159;160;160;161;161;162;160 10:33:33 INFO - PROCESS | 29954 | |3;audio-fft;75;76;79;125;75;76;74;74;99;76 10:33:33 INFO - PROCESS | 29954 | |4;audio-oscillator;85;86;122;86;84;86;121;85;84;120 10:33:33 INFO - PROCESS | 29954 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 10:33:33 INFO - PROCESS | 29954 | |6;imaging-darkroom;147;148;146;147;147;147;146;146;147;146 10:33:33 INFO - PROCESS | 29954 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 10:33:33 INFO - PROCESS | 29954 | |8;json-parse-financial;53;54;53;55;55;54;54;53;53;52 10:33:33 INFO - PROCESS | 29954 | |9;json-stringify-tinderbox;61;61;60;61;61;61;61;61;61;62 10:33:33 INFO - PROCESS | 29954 | |10;stanford-crypto-aes;80;79;80;79;79;80;81;80;136;78 10:33:33 INFO - PROCESS | 29954 | |11;stanford-crypto-ccm;123;125;122;130;121;120;128;120;143;138 10:33:33 INFO - PROCESS | 29954 | |12;stanford-crypto-pbkdf2;162;158;159;158;158;159;160;163;162;158 10:33:33 INFO - PROCESS | 29954 | |13;stanford-crypto-sha256-iterative;64;62;69;62;63;62;65;62;61;68 10:33:33 INFO - PROCESS | 29954 | __end_tp_report 10:33:33 INFO - PROCESS | 29954 | __start_cc_report 10:33:33 INFO - PROCESS | 29954 | _x_x_mozilla_cycle_collect,1635 10:33:33 INFO - PROCESS | 29954 | __end_cc_report 10:33:33 INFO - PROCESS | 29954 | __startTimestamp1464802413682__endTimestamp 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | ------- Summary: start ------- 10:33:33 INFO - PROCESS | 29954 | Number of tests: 14 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.32 (2.1%) stddev-sans-first:2.46 10:33:33 INFO - PROCESS | 29954 | Values: 109.0 104.0 111.0 109.0 113.0 110.0 110.0 109.0 109.0 111.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:142.50 stddev:17.77 (12.5%) stddev-sans-first:18.51 10:33:33 INFO - PROCESS | 29954 | Values: 149.0 124.0 136.0 175.0 126.0 127.0 154.0 125.0 155.0 124.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 10:33:33 INFO - PROCESS | 29954 | Values: 162.0 160.0 160.0 159.0 160.0 160.0 161.0 161.0 162.0 160.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:16.58 (21.8%) stddev-sans-first:17.33 10:33:33 INFO - PROCESS | 29954 | Values: 75.0 76.0 79.0 125.0 75.0 76.0 74.0 74.0 99.0 76.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.34 (20.4%) stddev-sans-first:17.94 10:33:33 INFO - PROCESS | 29954 | Values: 85.0 86.0 122.0 86.0 84.0 86.0 121.0 85.0 84.0 120.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:33:33 INFO - PROCESS | 29954 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:33:33 INFO - PROCESS | 29954 | Values: 147.0 148.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:33:33 INFO - PROCESS | 29954 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 10:33:33 INFO - PROCESS | 29954 | Values: 53.0 54.0 53.0 55.0 55.0 54.0 54.0 53.0 53.0 52.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 10:33:33 INFO - PROCESS | 29954 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:80.00 stddev:17.87 (22.3%) stddev-sans-first:18.85 10:33:33 INFO - PROCESS | 29954 | Values: 80.0 79.0 80.0 79.0 79.0 80.0 81.0 80.0 136.0 78.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:126.50 stddev:7.93 (6.3%) stddev-sans-first:8.28 10:33:33 INFO - PROCESS | 29954 | Values: 123.0 125.0 122.0 130.0 121.0 120.0 128.0 120.0 143.0 138.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:159.50 stddev:1.95 (1.2%) stddev-sans-first:1.88 10:33:33 INFO - PROCESS | 29954 | Values: 162.0 158.0 159.0 158.0 158.0 159.0 160.0 163.0 162.0 158.0 10:33:33 INFO - PROCESS | 29954 | 10:33:33 INFO - PROCESS | 29954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:2.74 (4.3%) stddev-sans-first:2.91 10:33:33 INFO - PROCESS | 29954 | Values: 64.0 62.0 69.0 62.0 63.0 62.0 65.0 62.0 61.0 68.0 10:33:33 INFO - PROCESS | 29954 | -------- Summary: end -------- 10:33:33 INFO - PROCESS | 29954 | 10:33:34 INFO - TEST-INFO | 29954: exit 0 10:33:34 INFO - TEST-OK | kraken | took 61138ms 10:33:34 INFO - SUITE-END | took 1174s 10:33:34 INFO - Completed test suite (00:19:34) 10:33:34 INFO - javascript benchmark 10:33:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.347876945841, 3120.344727607201, 3136.2316232523035, 3159.3839201355718, 3186.458302088645, 5279.762410691518, 5319.787208511655, 5387.676739395634, 5483.533899618527, 5485.561155107592, 5362.35651721794, 5365.7853685852615, 5407.188921661753, 5415.025295446818, 5436.836894893149, 4819.132556139884, 4824.927626085611, 4954.232094025432, 5005.699658020512, 5016.774245158958, 4965.726885021322, 4979.701217926936, 4999.375078115236, 5005.849824505271, 5008.29883816266, 4747.145513807513, 4806.975965120169, 4821.903561928777, 4877.6341774367065, 4929.457759646436, 4893.363862697862, 4900.852974410774, 4904.141775189328, 4965.081459929888, 4969.155243608595, 4871.182307516922, 4886.022795440926, 4887.29134275528, 4891.388576427947, 4891.584215341701, 5160.354955630546, 5274.997750427407, 5346.8395948121615, 5360.544353729938, 5412.566994640459, 5639.323281206241, 5684.573656975702, 5686.147077938343, 5688.345840228385, 5690.004249256363, 5739.770409183628, 5799.666076802359, 5806.941930580682, 5810.012297909366, 5810.21562089121, 5266.868328291824, 5322.20166974953, 5378.731063446812, 5385.084535628953, 5428.022955867942, 5914.645121292736, 5932.644041357532, 5935.228420305332, 5940.316863560746, 5950.0, 5670.5180059695385, 5670.688112153789, 5713.600047996683, 5726.112452569859, 5726.685032323179, 5559.722013899289, 5778.595498315078, 5856.795012174553, 5860.0, 5887.146363777314, 5839.0949402842625, 5847.502962248172, 5847.590668653239, 5848.3274423441, 5855.121731740188, 5431.131019036935, 5856.882862342814, 5860.531157507389, 5862.973979553561, 5863.296404431496, 4354.9782251088545, 4391.429114215195, 4392.516823149451, 4401.977990110029, 4402.031553058322, 3915.432262322004, 3919.3729003359326, 3920.4903362562686, 3939.0940083780893, 3957.485526881487, 5282.286891269706, 5321.813736519203, 5488.588355873326, 5511.255980442589, 5511.3937466878615, 5704.916065947456, 5752.338481074647, 5753.453421924911, 5755.712214389264, 5768.596198266081, 5426.810061647902, 5448.155535891943, 5453.318335208099, 5455.863603409867, 5464.699441530674, 4866.6106711463, 4933.753312334369, 4941.431735350408, 4955.82654607087, 4985.850424487271, 5940.821775346746, 6029.306629737549, 6032.215811944419, 6040.909386359208, 6090.025595904634, 5838.065909454467, 5845.386234445322, 5847.5906686533235, 5855.9121613176685, 5858.7070646468355, 5764.0, 5829.213056237523, 5859.179714840011, 6007.279126504847, 6022.698865056817, 5641.6050876439895, 5648.661080335193, 5659.377468478547, 5660.462256085665, 5707.058335374617, 5702.914456283076, 5715.971420142872, 5745.425457454221, 5752.165935939349, 5756.280464941882, 5482.835514934558, 5576.581756368208, 5598.496135347838, 5604.299462567179, 5631.070873306023, 5652.378238393856, 5663.150527420755, 5671.291088613923, 5677.233573467529, 5678.4605462480995, 5540.085885828793, 5553.250311207935, 5565.860853478695, 5572.247746554163, 5573.359063707563, 5539.362973257966, 5559.58303127259, 5611.775528978795, 5622.072358061037, 5716.79991200306, 5527.474889885454, 5532.0595498766115, 5535.916961245504, 5540.196671482532, 5583.190437386637], "value": 5313.192872427194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7755053079829, 614.5268143529482, 615.2063837649432, 640.2445114764582, 642.781454305536, 31315.843420782894, 43696.34455483167, 44399.0, 44635.107297854025, 44708.77645611772, 42424.787876060574, 42844.785776071076, 42847.14305713884, 42874.14251714964, 42874.785626071825, 8752.693655722034, 8940.418872773282, 8947.373683842134, 8950.060243674418, 8950.641974321019, 8561.0582835888, 8643.740687779376, 8657.393982421234, 8658.134186581323, 8672.826543469128, 8908.331875109361, 8971.14774096463, 8986.775330616754, 8990.325725570576, 8998.955005224965, 8859.689910853122, 8861.335399844973, 8870.201681848632, 8924.553772311423, 8925.821483570324, 8759.51822649754, 8881.86677199836, 8887.333449991213, 8893.510856902867, 8896.555172241362, 42414.0, 42441.78779106116, 42938.355924661155, 42967.78516107431, 43017.35473967893, 3463.2380876207194, 3556.1643013891717, 3619.6199399062984, 3715.758475699071, 4010.057636455431, 32372.0, 32904.34191316184, 32970.50544241838, 33034.6696533034, 34430.655693443, 4312.82748690052, 4333.566643335673, 4341.869743907688, 4347.304671103904, 4352.586504282088, 344922.0, 345029.0, 346063.0, 346138.0, 350134.0, 56520.43479565152, 56758.432415675314, 57364.71317643385, 57447.71276143593, 57461.425385745606, 60489.69755151196, 60569.69715151396, 60679.0, 60726.08910866341, 60756.0, 15590.844091559165, 16287.918560407123, 16290.0, 16660.666786664442, 16739.0, 12724.491020359266, 12876.098673092982, 12887.420066097047, 12893.290869002107, 12915.16051456671, 15825.287862046236, 16004.75992860108, 16048.27782749779, 16116.355345786038, 16120.596985075232, 5010.624203184776, 5708.20085188074, 5718.857028574235, 5918.112283157561, 5939.227900372924, 976.2336565795958, 1063.6330465989222, 1077.0898590690854, 1156.19066653343, 1187.89902858258, 32170.839145804588, 32224.0, 32549.51175732366, 32680.673193268238, 32854.67145328564, 1069.9518521666544, 1079.2876701377054, 1162.3200427749691, 1165.1785491228663, 1205.9397030148457, 16615.6676866462, 17178.1410929453, 17202.0, 17278.481645550655, 17461.912690436468, 585322.0, 588310.0, 590618.0, 591066.0, 594741.0, 56802.715986419804, 57363.0, 57538.0, 57684.0, 57745.711271443375, 1247.2267194339568, 1377.9517716879861, 1378.9448422063006, 1379.544750232421, 1390.1033833177544, 32184.678153218167, 33386.49920251247, 33472.66527334793, 33677.48696324837, 34032.31935361229, 48806.0, 48917.51082489272, 49227.50772492372, 49266.75366623144, 49395.50604493909, 426339.0, 427328.0, 429768.0, 429786.0, 429954.0, 33795.3240935175, 34282.14294642654, 44442.55557444384, 45038.77480612707, 45274.54725452835, 48081.78015593235, 48258.758706206245, 48345.5165448341, 48980.0, 49814.750926245135, 40397.59602403938, 40417.59582404138, 40795.92606563542, 41047.794761026, 41924.580754192066, 40115.598844012355, 40510.0, 40848.59151408448, 40960.38559421551, 41550.1689966205, 39546.60453395429, 40435.0, 40596.18807623772, 40739.38890916579, 40798.38802417907, 32353.676463235068, 35476.46785298274, 35663.0, 35901.28197436089, 36283.818580906925, 27768.0, 28184.29539261535, 28234.576481353208, 28245.435091297648, 28262.0], "value": 20160.778085063732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.33337326425266, 388.46004054364437, 394.4536816509135, 397.8508059477696, 408.93252613318805, 17730.556736081588, 19372.321968731096, 19732.112054957524, 19736.210551577937, 19745.11146998385, 18290.268389264413, 18580.721289180674, 18790.248390064415, 18945.62108757824, 18972.146253418596, 5538.501534861862, 5602.691851948141, 5695.288088988877, 5703.230063941356, 5728.656280623176, 5498.5876059295715, 5598.832035038935, 5607.0, 5623.0721930881355, 5626.634268772537, 5441.5102640762325, 5513.228148059255, 5585.58108141889, 5585.804496842611, 5594.412586678402, 5553.0, 5566.86082847928, 5577.749001294931, 5582.8325150245555, 5590.664560126405, 4882.267659851015, 4935.5436430475365, 4970.900581988376, 4987.977464619744, 4996.725180115092, 22518.32445026652, 22564.097436102536, 22741.658875116886, 22908.656370154462, 23024.194153204557, 2402.8798560071928, 2438.6098224284206, 2644.9684622997047, 2707.7969152313653, 2770.127409865886, 13767.242801645905, 14056.367463464168, 14307.427702891871, 14359.497417590439, 14362.712745745132, 1901.5436295289169, 1917.1756144857707, 1922.3464022232508, 1941.3108346536917, 2013.5167559785693, 76635.23364766393, 77170.61414692947, 77606.61196694037, 78195.60902195453, 79227.20772792256, 9683.41899486033, 9689.467079310565, 9797.31418800677, 10104.938981406993, 10121.898781012096, 13228.603141905758, 13379.331033448289, 13380.531681391105, 13387.330633468287, 13426.0, 7911.643976021093, 8018.959905200553, 8169.5098294102545, 8215.917840821634, 8301.335893128535, 8084.191580841869, 8217.808417779388, 8273.751787446387, 8361.498310101413, 8367.079621241659, 6169.413905678954, 6317.3366796486625, 6374.649394283359, 6438.130852334969, 6505.512086593524, 1769.9292028318723, 1789.2753434858903, 1801.3064969986387, 1809.4028970439724, 1844.492764489776, 1016.2987538598344, 1016.832222683249, 1026.4662375564815, 1048.528162326956, 1084.1110289562641, 18139.72790408145, 18541.0, 19058.904705476383, 19729.112189951487, 19806.90096549537, 1051.30613794895, 1052.847337136111, 1064.2497039587226, 1071.464267866067, 1083.8861919498497, 11184.161187910939, 11388.088952883749, 11464.140189485823, 11471.139664525028, 11482.253653512495, 480878.0, 484780.0, 494587.0, 495442.0, 506274.0, 57264.0, 74321.6283918577, 77576.0, 82078.17921820824, 83674.58162709269, 1048.4810019040624, 1051.3324039234988, 1054.6414219165367, 1089.1504626391427, 1094.0372472224392, 13831.585052448443, 16575.171241437638, 17172.141392930553, 17754.20106095203, 17790.377336793666, 29614.55578166286, 36233.81883090568, 41871.7906410466, 42250.788746056074, 42852.78573607112, 55318.72340638271, 56584.0, 58045.419545804005, 58618.4138158613, 58905.70547147237, 7688.923110768821, 8605.612747426256, 8889.555522223734, 8967.955160224157, 9050.637974480947, 13039.869601303866, 13451.46194152223, 13920.303984800517, 13928.72142557123, 14083.507077252247, 12121.75756484883, 12130.393480325773, 12173.087018473827, 12194.939025304817, 12296.446659900146, 11801.645950621494, 11818.763624727286, 11898.464569094585, 12061.819072714092, 12169.817452738393, 12084.818727718915, 12383.257004579755, 12531.122821402414, 12540.0, 12590.411732656148, 7720.0, 7919.336939242824, 8026.719064832703, 8133.186681331819, 8456.2812160967, 10829.999157159977, 11993.220440671328, 12125.75748485043, 12185.512579497075, 12405.131640785059], "value": 9262.863661314748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.2848433361648, 1462.2615579132537, 1503.7969874067, 1601.5195441367587, 1739.4433781190016, 7979.601019949001, 8324.375671824615, 8339.33285337173, 8590.098039705834, 8611.741647750561, 8414.116517765638, 8582.699605513808, 8587.78530536737, 8589.570521473932, 8600.053994060649, 2018.777934427212, 2282.1441959265276, 2283.931482055533, 2322.442613772691, 2354.540864531417, 2326.499802542453, 2332.6384410416413, 2336.6261398176293, 2337.4273303040777, 2339.894704738282, 2270.6594010898334, 2306.2850516339904, 2309.6997390339234, 2311.503026849227, 2312.9421764455938, 2029.168041103148, 2249.2352600115873, 2319.5940710375785, 2325.9069637214493, 2336.801371883375, 2240.238318971541, 2244.539869326784, 2245.921392751246, 2247.314569056437, 2297.574948634508, 8382.329413646894, 8438.704645337446, 8444.873326900102, 8453.196946290092, 8456.154384561556, 5052.494750524955, 5224.190250511177, 5225.059489291926, 5226.947730522684, 5227.137522308814, 3194.3132226571397, 3308.983455082733, 3362.3107263011025, 3409.6931276185264, 3411.675890790371, 1106.4633652678444, 1121.1255220927608, 1143.0741099709178, 1182.7516221593476, 1190.5297407523979, 11659.708507287301, 11665.358405287705, 11665.416729163593, 11679.065674746, 11704.648860534198, 4450.065486247924, 4579.6794224403975, 4612.400387949545, 4657.836975705834, 4659.4175728034, 9741.366811157252, 9786.0, 9787.412755234709, 9788.951055244679, 9792.21662267017, 4458.219811532968, 5156.1492353761205, 5183.714895680699, 5199.142141546678, 5204.297419848272, 4180.540140584533, 4247.830086796555, 4251.936220956688, 4655.208614535537, 4770.189067858403, 3822.503074600284, 3880.7283490155983, 3975.940360894589, 3994.8202330894596, 4061.7766022868436, 1250.93745312734, 1258.4955937684126, 1270.2632473165543, 1275.483429211171, 1277.4123903004722, 930.4742820306506, 940.6519587752439, 941.5245301122889, 943.9669611563562, 970.6990832841842, 5490.16079613334, 5652.74562644682, 5711.371749107595, 5769.105788602773, 5881.529477641779, 420.74124413485487, 433.44735462285837, 437.63457512976385, 439.18750311922685, 445.57670213297496, 3811.123441608446, 3883.8834834954996, 3890.7081968851885, 3894.2600905827803, 3942.48747662802, 10118.190544756402, 10444.477776111164, 10479.056884880245, 10501.474926253657, 10519.737006574744, 10157.441340726331, 10263.692089237335, 10327.586896524204, 10350.016748408889, 10374.22193335503, 7740.225977402328, 7886.566238856918, 7902.841943161219, 7922.643481043367, 7977.441579089524, 5512.972435137799, 5520.1167813149705, 5550.833474995757, 5558.583106267127, 5562.22128901946, 9670.903290967282, 9797.608095676092, 9843.950780246052, 9917.752056198653, 9922.702318930444, 9331.300152488726, 9630.518474076409, 9669.564869580745, 9945.30382873192, 9968.950155249177, 6647.0, 6850.143732033496, 6850.794476165723, 7402.6668799903055, 7632.1604623492485, 7678.731244406419, 7836.216378362118, 7895.526268423913, 8095.23095305945, 8133.0646975598565, 7268.309510596485, 7348.963255183904, 7424.1462231844025, 7427.0, 7579.772606821804, 7255.680126996768, 7310.0, 7329.853402931805, 7360.742374016883, 7431.962840185981, 6773.966130169318, 6782.0, 6832.692528836114, 6836.316368363124, 6839.794806155824, 4658.8136474542, 4762.666613337033, 4770.379850619397, 4778.976105119452, 4830.613550915848, 4746.33551302811, 4803.327534145293, 4870.172070747911, 4875.68308059975, 4986.376702912136], "value": 4384.945993276602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.92486690494644, 334.3079824762742, 341.1641478377975, 342.0320493004797, 344.24953601149485, 5376.327959005124, 5380.435054319299, 5389.8113566025195, 5392.811251606195, 5395.271638328824, 5260.237265596486, 5269.340157850274, 5316.6544174628625, 5336.466353364662, 5341.412444631087, 3896.8441262349615, 3980.2039592081555, 4054.128362402083, 4084.9387259191135, 4136.503619565657, 4071.4707088078508, 4131.504219493665, 4135.27632664284, 4166.812493437787, 4172.395002724603, 4093.2018256440006, 4112.095339025424, 4117.702923579078, 4122.113745544707, 4123.154753275587, 3890.7860067696124, 4031.737937034083, 4113.25961326961, 4114.691398145121, 4138.234426631083, 3588.5334906462253, 3628.983884512341, 3632.8365223565, 3636.7454278200535, 3642.417213245868, 5077.060743762416, 5081.339425874649, 5090.236464530313, 5128.179491281415, 5159.638825282232, 4512.864614061584, 4698.95301046992, 4736.194846876005, 4739.464386553177, 4750.836045168921, 5492.835214943558, 5527.309086364205, 5529.253550770634, 5534.335879694422, 5558.249636299089, 3947.4868267125375, 3984.4222587724907, 3987.501562304712, 3990.900227494336, 4001.679865610744, 5450.645708028966, 5703.173039909231, 5740.684262365568, 5789.739461724233, 5790.160426738142, 3967.8214480347874, 3970.305196590585, 3997.980010099931, 4016.196760647882, 4023.255697695877, 4028.4158796974275, 4033.1328764315813, 4068.4507591475362, 4095.774732389747, 4101.2207680540605, 4537.977310113428, 4649.418822647169, 4709.95290047102, 4726.125666751662, 4728.692634978715, 5494.890102197934, 5513.972430137824, 5525.834224973257, 5537.473939975695, 5555.611107222537, 1404.2346920928119, 1415.8725714685727, 1422.3101795629111, 1433.2332202271944, 1436.3608194353412, 886.1120116314415, 898.3038145437338, 903.9276857851356, 905.4069584422214, 924.9398789078689, 5266.657667251617, 5354.705491198021, 5357.517823395913, 5363.919541206885, 5420.159875219348, 5688.573356998241, 5707.429257074343, 5707.600467967202, 5746.195532625436, 5753.654780713171, 5241.514943830323, 5314.601404894648, 5378.655336165959, 5404.162354835007, 5458.208559758813, 3014.156036309837, 3022.637283525991, 3022.667506574319, 3033.014270362141, 3043.102284825937, 5845.515655846249, 5873.236479257669, 5875.618084824473, 5937.079752638348, 5970.611910225822, 5598.720063996784, 5744.684042377709, 5795.391483894215, 5823.82528524145, 5835.0, 5849.298084229835, 5859.861150679971, 5909.852253693606, 5943.989521781394, 5958.19564358806, 5380.973095134499, 5644.85887852807, 5681.744321505625, 5772.682502462405, 5794.82615521535, 5586.994341018656, 5685.379666794944, 5726.713664316684, 5732.168835518743, 5747.36778954323, 5936.732847021808, 5956.821295361146, 5958.19564358806, 5995.081573896311, 5996.340402555628, 4003.8798836034966, 4113.5886411359825, 4137.834486620502, 4144.772037537964, 4145.859888530557, 5758.740856661377, 5779.3590038275615, 5803.187553742564, 5826.41735826414, 5845.444682755132, 5439.0, 5588.6646801192055, 5614.522765564972, 5647.548196144381, 5655.406182350794, 5559.0, 5560.499555040065, 5569.053260945568, 5629.802956896489, 5646.237757902631, 5267.444474979297, 5464.890702185855, 5514.503694667499, 5522.66863988162, 5543.972280138735, 5457.508824205841, 5620.3536593290655, 5633.155026746021, 5639.6334238274385, 5671.347795003628, 5469.507744303032, 5475.330024342614, 5486.478784515464, 5528.170774383874, 5540.806071787468], "value": 4238.986357165988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.0958916424441, 836.0510820219049, 847.4576271186438, 852.3011130872683, 867.2844902955068, 12701.618951431461, 14339.498117565887, 14430.927845360784, 14499.855001449982, 14557.70884582309, 13901.443942242324, 14387.71224575508, 14933.253337333144, 14961.102333859948, 15548.45580404686, 676.3236763236763, 810.2909953790448, 812.7521106062649, 817.2032268538187, 817.284875733733, 687.9208890977527, 698.6471831724972, 698.6751160710294, 791.9881201781977, 817.9591020448984, 858.0347109501811, 859.1108203009886, 860.777695672144, 861.5692153923038, 862.2713806833216, 854.7435769269257, 856.6830272799042, 856.7943693513542, 857.2327766648846, 857.4469467193625, 521.1063026908831, 610.1092405088576, 623.0, 624.0420953835885, 629.8834715577633, 14640.487582934546, 14651.267436628126, 14653.853461465356, 14654.560363189015, 14659.780103298459, 12682.873171268353, 13465.124766890121, 13584.796228056586, 13593.116447430984, 13700.314984250846, 12506.249625022529, 12513.124081314312, 12791.296478693668, 12880.162789418659, 13265.005124615693, 4363.912721745547, 4393.912121757547, 4423.358613001129, 4520.977395113036, 4521.615662668677, 58257.0, 59061.40938590602, 59311.0, 60103.0, 61270.38729612736, 11010.39442830652, 11104.777904441866, 11135.498902549405, 11151.721206969729, 11333.886661133449, 19536.804631953783, 19544.70682939757, 19563.706544401844, 19566.70649940252, 19584.118714657874, 8153.063349897408, 8240.527841647601, 8399.538025408661, 8410.411271210956, 8505.659773608986, 4735.431748190171, 4757.881052973634, 4775.856724298276, 4786.593139583105, 4922.08941345845, 3269.0683155300626, 3364.5457863188644, 3375.7130643895052, 3377.4089534331392, 3377.7973321600293, 611.6819253987901, 630.2405601250482, 638.8434833465831, 641.371455973149, 657.5857209957696, 612.6599737145838, 660.7819419591523, 702.0978043214445, 718.5437247347971, 727.1238158019573, 9004.099590040943, 9073.410228335137, 9190.022603324114, 9229.0, 9291.442513449214, 706.9964650176819, 711.573056166296, 733.7908696021608, 734.5152199548272, 738.9002484664502, 4058.776767277828, 4130.235906357333, 4194.6853985951175, 4207.305794543927, 4302.333138363559, 67157.0, 68450.65774671095, 68706.65646671735, 69251.30748692449, 69479.65260173767, 59993.40006599965, 60235.39764602298, 60585.0, 61762.38237617656, 61984.380156198764, 51153.48846511562, 51448.74275628673, 52226.73886630542, 52465.47534524606, 52813.47186528162, 8489.0, 8560.700375486827, 8608.956955215184, 8746.737597872074, 8799.736007919773, 37087.81456092702, 37527.24945501129, 37736.245275094894, 38381.424278636405, 38567.614323857524, 46913.296300556205, 48679.5132048675, 51202.0, 51430.48569514257, 52045.0, 11107.777844443228, 11196.913116767706, 11215.158863085138, 11387.715307117389, 11833.290002599872, 12254.38728063611, 12418.379081046092, 12466.688332791753, 12480.5007799687, 12717.427715752998, 10130.430472485943, 12952.481900724242, 13162.934185329012, 13267.469301227842, 13513.0, 13292.468301267842, 13343.466261349826, 13360.465581377024, 13526.79709804334, 13646.385912634154, 12737.617871463872, 12771.489140434278, 12791.168574042658, 12831.743365132459, 12981.740365192833, 10964.396958167377, 11097.223194376316, 11278.548858045586, 11451.141164412536, 11462.598809041643, 11315.547378105113, 11472.88527114718, 11498.94250528742, 11525.193236473366, 11574.479148438171], "value": 6891.426972340665, "unit": "score"}], "name": "dromaeo_css", "value": 7090.852619031097, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 111.0, 109.0, 113.0, 110.0, 110.0, 109.0, 109.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 136.0, 175.0, 126.0, 127.0, 154.0, 125.0, 155.0, 124.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 159.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 125.0, 75.0, 76.0, 74.0, 74.0, 99.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 122.0, 86.0, 84.0, 86.0, 121.0, 85.0, 84.0, 120.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 55.0, 55.0, 54.0, 54.0, 53.0, 53.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 79.0, 79.0, 80.0, 81.0, 80.0, 136.0, 78.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 122.0, 130.0, 121.0, 120.0, 128.0, 120.0, 143.0, 138.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 159.0, 158.0, 158.0, 159.0, 160.0, 163.0, 162.0, 158.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 69.0, 62.0, 63.0, 62.0, 65.0, 62.0, 61.0, 68.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1497.1000000000001, "alertThreshold": 2.0}]} 10:33:34 INFO - Return code: 0 10:33:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:33:34 ERROR - # TBPL SUCCESS # 10:33:34 INFO - Running post-action listener: _resource_record_post_action 10:33:34 INFO - ##### 10:33:34 INFO - ##### Finished run-tests step (success) 10:33:34 INFO - ##### 10:33:34 INFO - Running post-run listener: _resource_record_post_run 10:33:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540635136; Read time: 12; Write time: 439676 10:33:35 INFO - TinderboxPrint: CPU usage
13.1% 10:33:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:33:35 INFO - TinderboxPrint: I/O write bytes / time
540,635,136 / 439,676 10:33:35 INFO - TinderboxPrint: CPU idle
8,270.8 (86.9%) 10:33:35 INFO - TinderboxPrint: CPU user
1,205.2 (12.7%) 10:33:35 INFO - TinderboxPrint: Swap in / out
0 / 0 10:33:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247758848; Read time: 0; Write time: 241968 10:33:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292876288; Read time: 12; Write time: 197708 10:33:35 INFO - Running post-run listener: _upload_blobber_files 10:33:35 INFO - Blob upload gear active. 10:33:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:35 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 10:33:35 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'] 10:33:35 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 10:33:36 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:36 INFO - (blobuploader) - INFO - Done attempting. 10:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:40 INFO - (blobuploader) - INFO - Done attempting. 10:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:41 INFO - (blobuploader) - INFO - Done attempting. 10:33:41 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:41 INFO - Return code: 0 10:33:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02d7b32f1aaa3a029fd0468ad763c17a1e48d9e99b1460f51679971a6b05a5498bf7fc2e50d7d6033b279e0c606d346ac709ffe6c18205639a7d18a874be6732", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd1fef68081861c7f2b44b0b20e945530bd83a75b734585b318068f1281ff7be17e3cf62aa9ec7127dcc731d670b6084de3fc31d1aecef6cb7c25faafe7586c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/932df3eb6d34e13cbe9aa1014f7a446864b7d46c1637f6cde6e2db60992c718d62dc8039e40671b8106b184c87150477aed741f35829eb8889c29b364e2af3df"} 10:33:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:41 INFO - Contents: 10:33:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02d7b32f1aaa3a029fd0468ad763c17a1e48d9e99b1460f51679971a6b05a5498bf7fc2e50d7d6033b279e0c606d346ac709ffe6c18205639a7d18a874be6732", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd1fef68081861c7f2b44b0b20e945530bd83a75b734585b318068f1281ff7be17e3cf62aa9ec7127dcc731d670b6084de3fc31d1aecef6cb7c25faafe7586c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/932df3eb6d34e13cbe9aa1014f7a446864b7d46c1637f6cde6e2db60992c718d62dc8039e40671b8106b184c87150477aed741f35829eb8889c29b364e2af3df"} 10:33:41 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:41 INFO - Copying logs to upload dir... 10:33:41 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.512269 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-01 10:33:41.569771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 10:33:41.572911) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02d7b32f1aaa3a029fd0468ad763c17a1e48d9e99b1460f51679971a6b05a5498bf7fc2e50d7d6033b279e0c606d346ac709ffe6c18205639a7d18a874be6732", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd1fef68081861c7f2b44b0b20e945530bd83a75b734585b318068f1281ff7be17e3cf62aa9ec7127dcc731d670b6084de3fc31d1aecef6cb7c25faafe7586c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/932df3eb6d34e13cbe9aa1014f7a446864b7d46c1637f6cde6e2db60992c718d62dc8039e40671b8106b184c87150477aed741f35829eb8889c29b364e2af3df"} build_url:https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/VFC8NOT1QcCtjM55GOKKJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02d7b32f1aaa3a029fd0468ad763c17a1e48d9e99b1460f51679971a6b05a5498bf7fc2e50d7d6033b279e0c606d346ac709ffe6c18205639a7d18a874be6732", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cd1fef68081861c7f2b44b0b20e945530bd83a75b734585b318068f1281ff7be17e3cf62aa9ec7127dcc731d670b6084de3fc31d1aecef6cb7c25faafe7586c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/932df3eb6d34e13cbe9aa1014f7a446864b7d46c1637f6cde6e2db60992c718d62dc8039e40671b8106b184c87150477aed741f35829eb8889c29b364e2af3df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 10:33:41.598275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:33:41.598623) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1464801185.878390-48944214 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 10:33:41.683129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 10:33:41.683436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 10:33:41.683720) ========= ========= Total master_lag: 0.16 =========