builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1463817737.79 results: success (0) buildid: 20160520223047 builduid: a939ada10b084b9fad9fdac04744e3f4 revision: f1f2644d34440fe38c098e323bf570e09197e51a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:17.791138) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:17.791648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:17.791934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:17.841221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:17.841525) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 01:02:17-- 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% 111M=0s 2016-05-21 01:02:18 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143382 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:17.998789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:17.999087) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015695 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:18.049078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:18.049406) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f1f2644d34440fe38c098e323bf570e09197e51a --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 f1f2644d34440fe38c098e323bf570e09197e51a --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=9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 01:02:18,246 truncating revision to first 12 chars 2016-05-21 01:02:18,247 Setting DEBUG logging. 2016-05-21 01:02:18,247 attempt 1/10 2016-05-21 01:02:18,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f1f2644d3444?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 01:02:18,528 unpacking tar archive at: mozilla-central-f1f2644d3444/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:18.617681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:18.618001) ========= script_repo_revision: f1f2644d34440fe38c098e323bf570e09197e51a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:18.618424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:18.618984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:02:18.629560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-21 01:02:18.629836) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:02:18 INFO - MultiFileLogger online at 20160521 01:02:18 in /builds/slave/test 01:02:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:02:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:02:18 INFO - {'append_to_log': False, 01:02:18 INFO - 'base_work_dir': '/builds/slave/test', 01:02:18 INFO - 'blob_upload_branch': 'Firefox', 01:02:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:02:18 INFO - 'branch': 'Firefox', 01:02:18 INFO - 'buildbot_json_path': 'buildprops.json', 01:02:18 INFO - 'config_files': ('talos/linux_config.py',), 01:02:18 INFO - 'default_actions': ('clobber', 01:02:18 INFO - 'read-buildbot-config', 01:02:18 INFO - 'download-and-extract', 01:02:18 INFO - 'populate-webroot', 01:02:18 INFO - 'create-virtualenv', 01:02:18 INFO - 'install', 01:02:18 INFO - 'run-tests'), 01:02:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:02:18 INFO - 'download_minidump_stackwalk': True, 01:02:18 INFO - 'download_symbols': 'ondemand', 01:02:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:02:18 INFO - 'tooltool.py': '/tools/tooltool.py', 01:02:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:02:18 INFO - '/tools/misc-python/virtualenv.py')}, 01:02:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:02:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:02:18 INFO - 'installer_path': 'installer.exe', 01:02:18 INFO - 'log_level': 'info', 01:02:18 INFO - 'log_name': 'talos', 01:02:18 INFO - 'log_to_console': True, 01:02:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:02:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:02:18 INFO - 'opt_config_files': (), 01:02:18 INFO - 'pip_index': False, 01:02:18 INFO - 'sps_profile': False, 01:02:18 INFO - 'sps_profile_interval': 0, 01:02:18 INFO - 'suite': 'dromaeojs-e10s', 01:02:18 INFO - 'system_bits': '32', 01:02:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:02:18 INFO - 'title': 'talos-linux64-ix-013', 01:02:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:02:18 INFO - 'use_talos_json': True, 01:02:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:02:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:02:18 INFO - 'work_dir': 'build'} 01:02:18 INFO - ##### 01:02:18 INFO - ##### Running clobber step. 01:02:18 INFO - ##### 01:02:18 INFO - Running pre-action listener: _resource_record_pre_action 01:02:18 INFO - Running main action method: clobber 01:02:18 INFO - rmtree: /builds/slave/test/build 01:02:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:02:19 INFO - Running post-action listener: _resource_record_post_action 01:02:19 INFO - ##### 01:02:19 INFO - ##### Finished clobber step (success) 01:02:19 INFO - ##### 01:02:19 INFO - ##### 01:02:19 INFO - ##### Running read-buildbot-config step. 01:02:19 INFO - ##### 01:02:19 INFO - Running pre-action listener: _resource_record_pre_action 01:02:19 INFO - Running main action method: read_buildbot_config 01:02:19 INFO - Using buildbot properties: 01:02:19 INFO - { 01:02:19 INFO - "project": "", 01:02:19 INFO - "product": "firefox", 01:02:19 INFO - "script_repo_revision": "production", 01:02:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:02:19 INFO - "repository": "", 01:02:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 01:02:19 INFO - "buildid": "20160520223047", 01:02:19 INFO - "pgo_build": "True", 01:02:19 INFO - "basedir": "/builds/slave/test", 01:02:19 INFO - "buildnumber": 215, 01:02:19 INFO - "slavename": "talos-linux64-ix-013", 01:02:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:02:19 INFO - "platform": "ubuntu64_hw", 01:02:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:02:19 INFO - "branch": "mozilla-central", 01:02:19 INFO - "repo_path": "mozilla-central", 01:02:19 INFO - "revision": "f1f2644d34440fe38c098e323bf570e09197e51a", 01:02:19 INFO - "stage_platform": "linux64-pgo", 01:02:19 INFO - "builduid": "a939ada10b084b9fad9fdac04744e3f4", 01:02:19 INFO - "slavebuilddir": "test" 01:02:19 INFO - } 01:02:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:02:19 INFO - Running post-action listener: _resource_record_post_action 01:02:19 INFO - ##### 01:02:19 INFO - ##### Finished read-buildbot-config step (success) 01:02:19 INFO - ##### 01:02:19 INFO - ##### 01:02:19 INFO - ##### Running download-and-extract step. 01:02:19 INFO - ##### 01:02:19 INFO - Running pre-action listener: _resource_record_pre_action 01:02:19 INFO - Running main action method: download_and_extract 01:02:19 INFO - mkdir: /builds/slave/test/build/tests 01:02:19 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')]} 01:02:19 INFO - https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:02:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:02:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:02:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:26 INFO - Downloaded 1361 bytes. 01:02:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:02:26 INFO - Using the following test package requirements: 01:02:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:02:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:02:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'jsshell-linux-x86_64.zip'], 01:02:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:02:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:02:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:02:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:02:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:02:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:26 INFO - https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:02:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:02:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:02:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:33 INFO - Downloaded 24389074 bytes. 01:02:33 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'] 01:02:33 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 01:02:34 INFO - Return code: 0 01:02:34 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 01:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:34 INFO - https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:37 INFO - Downloaded 24389074 bytes. 01:02:37 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'] 01:02:37 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 01:02:38 INFO - Return code: 0 01:02: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')]} 01:02:38 INFO - https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:02:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:40 INFO - Downloaded 10840359 bytes. 01:02:40 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'] 01:02:40 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 01:02:40 INFO - Return code: 0 01:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:40 INFO - https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNdcFojLT2WgPhr7qALQ6g/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 01:02:41 INFO - Downloaded 58606453 bytes. 01:02:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:02:41 INFO - mkdir: /builds/slave/test/properties 01:02:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:02:41 INFO - Writing to file /builds/slave/test/properties/build_url 01:02:41 INFO - Contents: 01:02:41 INFO - build_url:https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:02:52 INFO - Running post-action listener: _resource_record_post_action 01:02:52 INFO - Running post-action listener: set_extra_try_arguments 01:02:52 INFO - ##### 01:02:52 INFO - ##### Finished download-and-extract step (success) 01:02:52 INFO - ##### 01:02:52 INFO - ##### 01:02:52 INFO - ##### Running populate-webroot step. 01:02:52 INFO - ##### 01:02:52 INFO - Running pre-action listener: _resource_record_pre_action 01:02:52 INFO - Running main action method: populate_webroot 01:02:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:02:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:02:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:02:52 INFO - '--tppagecycles', 01:02:52 INFO - '7'], 01:02:52 INFO - 'tests': ['tsvgm']}}, 01:02:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:02:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:02:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:02:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:02:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['damp', 'tps']}, 01:02:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'tests': ['damp', 'tps']}, 01:02:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['dromaeo_dom']}, 01:02:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:02:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['a11yr', 01:02:52 INFO - 'ts_paint', 01:02:52 INFO - 'tpaint', 01:02:52 INFO - 'sessionrestore', 01:02:52 INFO - 'sessionrestore_no_auto_restore', 01:02:52 INFO - 'tabpaint']}, 01:02:52 INFO - 'other-e10s': {'tests': ['a11yr', 01:02:52 INFO - 'ts_paint', 01:02:52 INFO - 'tpaint', 01:02:52 INFO - 'sessionrestore', 01:02:52 INFO - 'sessionrestore_no_auto_restore', 01:02:52 INFO - 'tabpaint']}, 01:02:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:02:52 INFO - 'ts_paint', 01:02:52 INFO - 'tpaint', 01:02:52 INFO - 'sessionrestore', 01:02:52 INFO - 'sessionrestore_no_auto_restore', 01:02:52 INFO - 'tabpaint']}, 01:02:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:02:52 INFO - 'ts_paint', 01:02:52 INFO - 'tpaint', 01:02:52 INFO - 'sessionrestore', 01:02:52 INFO - 'sessionrestore_no_auto_restore', 01:02:52 INFO - 'tabpaint']}, 01:02:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['a11yr', 01:02:52 INFO - 'ts_paint', 01:02:52 INFO - 'tpaint', 01:02:52 INFO - 'sessionrestore', 01:02:52 INFO - 'sessionrestore_no_auto_restore', 01:02:52 INFO - 'tabpaint']}, 01:02:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['a11yr', 01:02:52 INFO - 'ts_paint', 01:02:52 INFO - 'tpaint', 01:02:52 INFO - 'sessionrestore', 01:02:52 INFO - 'sessionrestore_no_auto_restore', 01:02:52 INFO - 'tabpaint']}, 01:02:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['tsvgx', 01:02:52 INFO - 'tsvgr_opacity', 01:02:52 INFO - 'tart', 01:02:52 INFO - 'tscrollx', 01:02:52 INFO - 'cart']}, 01:02:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:02:52 INFO - 'tsvgr_opacity', 01:02:52 INFO - 'tart', 01:02:52 INFO - 'tscrollx', 01:02:52 INFO - 'cart']}, 01:02:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'talos_options': ['--disable-e10s'], 01:02:52 INFO - 'tests': ['tp5o']}, 01:02:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'tests': ['tp5o']}, 01:02:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'talos_options': ['--disable-e10s', 01:02:52 INFO - '--xperf_path', 01:02:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:52 INFO - 'tests': ['tp5n']}, 01:02:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:52 INFO - 'talos_options': ['--xperf_path', 01:02:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:52 INFO - 'tests': ['tp5n']}}, 01:02:52 INFO - 'talos.zip': {'path': '', 01:02:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:02:52 INFO - Running post-action listener: _resource_record_post_action 01:02:52 INFO - ##### 01:02:52 INFO - ##### Finished populate-webroot step (success) 01:02:52 INFO - ##### 01:02:52 INFO - ##### 01:02:52 INFO - ##### Running create-virtualenv step. 01:02:52 INFO - ##### 01:02:52 INFO - Running pre-action listener: _resource_record_pre_action 01:02:52 INFO - Running main action method: create_virtualenv 01:02:52 INFO - Creating virtualenv /builds/slave/test/build/venv 01:02:52 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 01:02:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:02:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:02:52 INFO - Using real prefix '/usr' 01:02:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:02:53 INFO - Installing distribute.............................................................................................................................................................................................done. 01:02:55 INFO - Installing pip.................done. 01:02:55 INFO - Return code: 0 01:02:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:55 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:02:55 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 01:02:55 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 01:02:55 INFO - Using env: {'DISPLAY': ':0', 01:02:55 INFO - 'HOME': '/home/cltbld', 01:02:55 INFO - 'LANG': 'en_US.UTF-8', 01:02:55 INFO - 'LANGUAGE': 'en_US:en', 01:02:55 INFO - 'LOGNAME': 'cltbld', 01:02:55 INFO - 'MAIL': '/var/mail/cltbld', 01:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:55 INFO - 'MOZ_NO_REMOTE': '1', 01:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:55 INFO - 'NO_EM_RESTART': '1', 01:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:55 INFO - 'PWD': '/builds/slave/test', 01:02:55 INFO - 'SHELL': '/bin/bash', 01:02:55 INFO - 'SHLVL': '1', 01:02:55 INFO - 'TERM': 'linux', 01:02:55 INFO - 'TMOUT': '86400', 01:02:55 INFO - 'USER': 'cltbld', 01:02:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:55 INFO - '_': '/tools/buildbot/bin/python'} 01:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:55 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 01:02:55 INFO - Cleaning up... 01:02:55 INFO - Return code: 0 01:02:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:55 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:02:55 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 01:02:55 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 01:02:55 INFO - Using env: {'DISPLAY': ':0', 01:02:55 INFO - 'HOME': '/home/cltbld', 01:02:55 INFO - 'LANG': 'en_US.UTF-8', 01:02:55 INFO - 'LANGUAGE': 'en_US:en', 01:02:55 INFO - 'LOGNAME': 'cltbld', 01:02:55 INFO - 'MAIL': '/var/mail/cltbld', 01:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:55 INFO - 'MOZ_NO_REMOTE': '1', 01:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:55 INFO - 'NO_EM_RESTART': '1', 01:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:55 INFO - 'PWD': '/builds/slave/test', 01:02:55 INFO - 'SHELL': '/bin/bash', 01:02:55 INFO - 'SHLVL': '1', 01:02:55 INFO - 'TERM': 'linux', 01:02:55 INFO - 'TMOUT': '86400', 01:02:55 INFO - 'USER': 'cltbld', 01:02:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:55 INFO - '_': '/tools/buildbot/bin/python'} 01:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:55 INFO - Downloading/unpacking psutil>=3.1.1 01:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:02:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:57 INFO - Installing collected packages: psutil 01:02:57 INFO - Running setup.py install for psutil 01:02:57 INFO - building 'psutil._psutil_linux' extension 01:02:57 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 01:02:58 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 01:02:58 INFO - building 'psutil._psutil_posix' extension 01:02:58 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 01:02:58 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 01:02:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:58 INFO - Successfully installed psutil 01:02:58 INFO - Cleaning up... 01:02:58 INFO - Return code: 0 01:02:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:58 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:02:58 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 01:02:58 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 01:02:58 INFO - Using env: {'DISPLAY': ':0', 01:02:58 INFO - 'HOME': '/home/cltbld', 01:02:58 INFO - 'LANG': 'en_US.UTF-8', 01:02:58 INFO - 'LANGUAGE': 'en_US:en', 01:02:58 INFO - 'LOGNAME': 'cltbld', 01:02:58 INFO - 'MAIL': '/var/mail/cltbld', 01:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:58 INFO - 'MOZ_NO_REMOTE': '1', 01:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:58 INFO - 'NO_EM_RESTART': '1', 01:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:58 INFO - 'PWD': '/builds/slave/test', 01:02:58 INFO - 'SHELL': '/bin/bash', 01:02:58 INFO - 'SHLVL': '1', 01:02:58 INFO - 'TERM': 'linux', 01:02:58 INFO - 'TMOUT': '86400', 01:02:58 INFO - 'USER': 'cltbld', 01:02:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:58 INFO - '_': '/tools/buildbot/bin/python'} 01:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:03:00 INFO - Installing collected packages: mozsystemmonitor 01:03:00 INFO - Running setup.py install for mozsystemmonitor 01:03:00 INFO - Successfully installed mozsystemmonitor 01:03:00 INFO - Cleaning up... 01:03:00 INFO - Return code: 0 01:03:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:00 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:03:00 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 01:03:00 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 01:03:00 INFO - Using env: {'DISPLAY': ':0', 01:03:00 INFO - 'HOME': '/home/cltbld', 01:03:00 INFO - 'LANG': 'en_US.UTF-8', 01:03:00 INFO - 'LANGUAGE': 'en_US:en', 01:03:00 INFO - 'LOGNAME': 'cltbld', 01:03:00 INFO - 'MAIL': '/var/mail/cltbld', 01:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:00 INFO - 'MOZ_NO_REMOTE': '1', 01:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:00 INFO - 'NO_EM_RESTART': '1', 01:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:00 INFO - 'PWD': '/builds/slave/test', 01:03:00 INFO - 'SHELL': '/bin/bash', 01:03:00 INFO - 'SHLVL': '1', 01:03:00 INFO - 'TERM': 'linux', 01:03:00 INFO - 'TMOUT': '86400', 01:03:00 INFO - 'USER': 'cltbld', 01:03:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:00 INFO - '_': '/tools/buildbot/bin/python'} 01:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:00 INFO - Downloading/unpacking blobuploader==1.2.4 01:03:00 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 01:03:00 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 01:03:00 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 01:03:00 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 01:03:00 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 01:03:00 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 01:03:02 INFO - Downloading blobuploader-1.2.4.tar.gz 01:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:03:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:03:02 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 01:03:02 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 01:03:02 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 01:03:02 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 01:03:02 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 01:03:02 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 01:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:03:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:03 INFO - Downloading docopt-0.6.1.tar.gz 01:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:03:03 INFO - Installing collected packages: blobuploader, requests, docopt 01:03:03 INFO - Running setup.py install for blobuploader 01:03:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:03:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:03:03 INFO - Running setup.py install for requests 01:03:03 INFO - Running setup.py install for docopt 01:03:04 INFO - Successfully installed blobuploader requests docopt 01:03:04 INFO - Cleaning up... 01:03:04 INFO - Return code: 0 01:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:04 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')]} 01:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:04 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')]} 01:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:04 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:03:04 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 01:03:04 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 01:03:04 INFO - Using env: {'DISPLAY': ':0', 01:03:04 INFO - 'HOME': '/home/cltbld', 01:03:04 INFO - 'LANG': 'en_US.UTF-8', 01:03:04 INFO - 'LANGUAGE': 'en_US:en', 01:03:04 INFO - 'LOGNAME': 'cltbld', 01:03:04 INFO - 'MAIL': '/var/mail/cltbld', 01:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:04 INFO - 'MOZ_NO_REMOTE': '1', 01:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:04 INFO - 'NO_EM_RESTART': '1', 01:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:04 INFO - 'PWD': '/builds/slave/test', 01:03:04 INFO - 'SHELL': '/bin/bash', 01:03:04 INFO - 'SHLVL': '1', 01:03:04 INFO - 'TERM': 'linux', 01:03:04 INFO - 'TMOUT': '86400', 01:03:04 INFO - 'USER': 'cltbld', 01:03:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:04 INFO - '_': '/tools/buildbot/bin/python'} 01:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:04 INFO - Running setup.py (path:/tmp/pip-REiEsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:04 INFO - Running setup.py (path:/tmp/pip-EbbkEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:04 INFO - Running setup.py (path:/tmp/pip-bzj805-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:04 INFO - Running setup.py (path:/tmp/pip-Toe5oJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:04 INFO - Running setup.py (path:/tmp/pip-OSLhEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:04 INFO - Running setup.py (path:/tmp/pip-lvzN_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:04 INFO - Running setup.py (path:/tmp/pip-2n2XNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:04 INFO - Running setup.py (path:/tmp/pip-Zzyvim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:04 INFO - Running setup.py (path:/tmp/pip-rSxoDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:04 INFO - Running setup.py (path:/tmp/pip-s1jNwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:04 INFO - Running setup.py (path:/tmp/pip-Lf3Uto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:05 INFO - Running setup.py (path:/tmp/pip-GGd8vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:05 INFO - Running setup.py (path:/tmp/pip-xrVSc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:05 INFO - Running setup.py (path:/tmp/pip-Jxulu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:05 INFO - Running setup.py (path:/tmp/pip-2tITlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:05 INFO - Running setup.py (path:/tmp/pip-8L7oRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:05 INFO - Running setup.py (path:/tmp/pip-XhZyZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:03:05 INFO - Running setup.py install for manifestparser 01:03:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:03:05 INFO - Running setup.py install for mozcrash 01:03:05 INFO - Running setup.py install for mozdebug 01:03:05 INFO - Running setup.py install for mozdevice 01:03:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:03:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:03:05 INFO - Running setup.py install for mozfile 01:03:06 INFO - Running setup.py install for mozhttpd 01:03:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Running setup.py install for mozinfo 01:03:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Running setup.py install for mozInstall 01:03:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Running setup.py install for mozleak 01:03:06 INFO - Running setup.py install for mozlog 01:03:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Running setup.py install for moznetwork 01:03:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Running setup.py install for mozprocess 01:03:06 INFO - Running setup.py install for mozprofile 01:03:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Running setup.py install for mozrunner 01:03:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:03:06 INFO - Running setup.py install for mozscreenshot 01:03:07 INFO - Running setup.py install for moztest 01:03:07 INFO - Running setup.py install for mozversion 01:03:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:03:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:03:07 INFO - Cleaning up... 01:03:07 INFO - Return code: 0 01:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:07 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')]} 01:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:07 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')]} 01:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:07 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:03:07 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 01:03:07 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 01:03:07 INFO - Using env: {'DISPLAY': ':0', 01:03:07 INFO - 'HOME': '/home/cltbld', 01:03:07 INFO - 'LANG': 'en_US.UTF-8', 01:03:07 INFO - 'LANGUAGE': 'en_US:en', 01:03:07 INFO - 'LOGNAME': 'cltbld', 01:03:07 INFO - 'MAIL': '/var/mail/cltbld', 01:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:07 INFO - 'MOZ_NO_REMOTE': '1', 01:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:07 INFO - 'NO_EM_RESTART': '1', 01:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:07 INFO - 'PWD': '/builds/slave/test', 01:03:07 INFO - 'SHELL': '/bin/bash', 01:03:07 INFO - 'SHLVL': '1', 01:03:07 INFO - 'TERM': 'linux', 01:03:07 INFO - 'TMOUT': '86400', 01:03:07 INFO - 'USER': 'cltbld', 01:03:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:07 INFO - '_': '/tools/buildbot/bin/python'} 01:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:07 INFO - Running setup.py (path:/tmp/pip-_pCnJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:07 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)) 01:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:07 INFO - Running setup.py (path:/tmp/pip-PGBH0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:07 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)) 01:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:07 INFO - Running setup.py (path:/tmp/pip-GOWyAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:07 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)) 01:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:07 INFO - Running setup.py (path:/tmp/pip-agPde5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:07 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)) 01:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:07 INFO - Running setup.py (path:/tmp/pip-CQhaGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:07 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)) 01:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:07 INFO - Running setup.py (path:/tmp/pip-OtRInL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:07 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)) 01:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:07 INFO - Running setup.py (path:/tmp/pip-tzqc5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:08 INFO - Running setup.py (path:/tmp/pip-XANZBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:08 INFO - Running setup.py (path:/tmp/pip-MvDJ6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:08 INFO - Running setup.py (path:/tmp/pip-Rrye2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:08 INFO - Running setup.py (path:/tmp/pip-6CMagr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:08 INFO - Running setup.py (path:/tmp/pip-emBTa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:08 INFO - Running setup.py (path:/tmp/pip-DDDdnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:08 INFO - Running setup.py (path:/tmp/pip-IDe7J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:08 INFO - Running setup.py (path:/tmp/pip-vJQgzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:08 INFO - Running setup.py (path:/tmp/pip-GLd1DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:08 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)) 01:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:08 INFO - Running setup.py (path:/tmp/pip-iuuPHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:03:09 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 01:03:09 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 01:03:09 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 01:03:09 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 01:03:09 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 01:03:09 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 01:03:10 INFO - Downloading blessings-1.6.tar.gz 01:03:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:03:11 INFO - Installing collected packages: blessings 01:03:11 INFO - Running setup.py install for blessings 01:03:11 INFO - Successfully installed blessings 01:03:11 INFO - Cleaning up... 01:03:11 INFO - Return code: 0 01:03:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:11 INFO - Reading from file tmpfile_stdout 01:03:11 INFO - Current package versions: 01:03:11 INFO - argparse == 1.2.1 01:03:11 INFO - blessings == 1.6 01:03:11 INFO - blobuploader == 1.2.4 01:03:11 INFO - docopt == 0.6.1 01:03:11 INFO - manifestparser == 1.1 01:03:11 INFO - mozInstall == 1.12 01:03:11 INFO - mozcrash == 0.17 01:03:11 INFO - mozdebug == 0.1 01:03:11 INFO - mozdevice == 0.48 01:03:11 INFO - mozfile == 1.2 01:03:11 INFO - mozhttpd == 0.7 01:03:11 INFO - mozinfo == 0.9 01:03:11 INFO - mozleak == 0.1 01:03:11 INFO - mozlog == 3.2 01:03:11 INFO - moznetwork == 0.27 01:03:11 INFO - mozprocess == 0.22 01:03:11 INFO - mozprofile == 0.28 01:03:11 INFO - mozrunner == 6.11 01:03:11 INFO - mozscreenshot == 0.1 01:03:11 INFO - mozsystemmonitor == 0.3 01:03:11 INFO - moztest == 0.7 01:03:11 INFO - mozversion == 1.4 01:03:11 INFO - psutil == 3.1.1 01:03:11 INFO - requests == 1.2.3 01:03:11 INFO - wsgiref == 0.1.2 01:03:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03: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')]} 01:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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')]} 01:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:11 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:03:11 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 01:03:11 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 01:03:11 INFO - Using env: {'DISPLAY': ':0', 01:03:11 INFO - 'HOME': '/home/cltbld', 01:03:11 INFO - 'LANG': 'en_US.UTF-8', 01:03:11 INFO - 'LANGUAGE': 'en_US:en', 01:03:11 INFO - 'LOGNAME': 'cltbld', 01:03:11 INFO - 'MAIL': '/var/mail/cltbld', 01:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:11 INFO - 'MOZ_NO_REMOTE': '1', 01:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:11 INFO - 'NO_EM_RESTART': '1', 01:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:11 INFO - 'PWD': '/builds/slave/test', 01:03:11 INFO - 'SHELL': '/bin/bash', 01:03:11 INFO - 'SHLVL': '1', 01:03:11 INFO - 'TERM': 'linux', 01:03:11 INFO - 'TMOUT': '86400', 01:03:11 INFO - 'USER': 'cltbld', 01:03:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:11 INFO - '_': '/tools/buildbot/bin/python'} 01:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 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)) 01:03:11 INFO - Cleaning up... 01:03:11 INFO - Return code: 0 01:03:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:03: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')]} 01:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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')]} 01:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:11 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:03:11 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 01:03:11 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 01:03:11 INFO - Using env: {'DISPLAY': ':0', 01:03:11 INFO - 'HOME': '/home/cltbld', 01:03:11 INFO - 'LANG': 'en_US.UTF-8', 01:03:11 INFO - 'LANGUAGE': 'en_US:en', 01:03:11 INFO - 'LOGNAME': 'cltbld', 01:03:11 INFO - 'MAIL': '/var/mail/cltbld', 01:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:11 INFO - 'MOZ_NO_REMOTE': '1', 01:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:11 INFO - 'NO_EM_RESTART': '1', 01:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:11 INFO - 'PWD': '/builds/slave/test', 01:03:11 INFO - 'SHELL': '/bin/bash', 01:03:11 INFO - 'SHLVL': '1', 01:03:11 INFO - 'TERM': 'linux', 01:03:11 INFO - 'TMOUT': '86400', 01:03:11 INFO - 'USER': 'cltbld', 01:03:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:11 INFO - '_': '/tools/buildbot/bin/python'} 01:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:11 INFO - Downloading/unpacking jsonschema 01:03:11 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 01:03:11 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 01:03:11 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 01:03:11 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 01:03:11 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 01:03:11 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 01:03:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:03:13 INFO - Downloading/unpacking functools32 (from jsonschema) 01:03:13 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 01:03:13 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 01:03:13 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 01:03:13 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 01:03:13 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 01:03:13 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 01:03:13 INFO - Downloading functools32-3.2.3-2.tar.gz 01:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:03:13 INFO - warning: no files found matching '*.txt' 01:03:13 INFO - no previously-included directories found matching 'build' 01:03:13 INFO - no previously-included directories found matching 'dist' 01:03:13 INFO - no previously-included directories found matching '.git*' 01:03:13 INFO - Installing collected packages: jsonschema, functools32 01:03:14 INFO - Running setup.py install for functools32 01:03:14 INFO - warning: no files found matching '*.txt' 01:03:14 INFO - no previously-included directories found matching 'build' 01:03:14 INFO - no previously-included directories found matching 'dist' 01:03:14 INFO - no previously-included directories found matching '.git*' 01:03:14 INFO - Successfully installed jsonschema functools32 01:03:14 INFO - Cleaning up... 01:03:14 INFO - Return code: 0 01:03:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:03: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')]} 01:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03: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')]} 01:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:14 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 0x7f3adcd46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c0770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', '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 01:03:14 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 01:03:14 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 01:03:14 INFO - Using env: {'DISPLAY': ':0', 01:03:14 INFO - 'HOME': '/home/cltbld', 01:03:14 INFO - 'LANG': 'en_US.UTF-8', 01:03:14 INFO - 'LANGUAGE': 'en_US:en', 01:03:14 INFO - 'LOGNAME': 'cltbld', 01:03:14 INFO - 'MAIL': '/var/mail/cltbld', 01:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:14 INFO - 'MOZ_NO_REMOTE': '1', 01:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:14 INFO - 'NO_EM_RESTART': '1', 01:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:14 INFO - 'PWD': '/builds/slave/test', 01:03:14 INFO - 'SHELL': '/bin/bash', 01:03:14 INFO - 'SHLVL': '1', 01:03:14 INFO - 'TERM': 'linux', 01:03:14 INFO - 'TMOUT': '86400', 01:03:14 INFO - 'USER': 'cltbld', 01:03:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:14 INFO - '_': '/tools/buildbot/bin/python'} 01:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:14 INFO - Downloading/unpacking flake8 01:03:14 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 01:03:14 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 01:03:14 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 01:03:14 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 01:03:14 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 01:03:14 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 01:03:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:03:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:03:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:16 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 01:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:03:17 INFO - no previously-included directories found matching 'docs/_build' 01:03:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:03:17 INFO - Running setup.py install for pep8 01:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:03:17 INFO - no previously-included directories found matching 'docs/_build' 01:03:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:03:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:03:17 INFO - Cleaning up... 01:03:17 INFO - Return code: 0 01:03:17 INFO - Running post-action listener: _resource_record_post_action 01:03:17 INFO - Running post-action listener: _start_resource_monitoring 01:03:17 INFO - Starting resource monitoring. 01:03:17 INFO - ##### 01:03:17 INFO - ##### Finished create-virtualenv step (success) 01:03:17 INFO - ##### 01:03:17 INFO - ##### 01:03:17 INFO - ##### Running install step. 01:03:17 INFO - ##### 01:03:17 INFO - Running pre-action listener: _resource_record_pre_action 01:03:17 INFO - Running main action method: install 01:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:17 INFO - Reading from file tmpfile_stdout 01:03:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:03:17 INFO - Reading from file tmpfile_stdout 01:03:17 INFO - Output received: 01:03:17 INFO - Usage: mozinstall [options] installer 01:03:17 INFO - Options: 01:03:17 INFO - -h, --help show this help message and exit 01:03:17 INFO - -d DEST, --destination=DEST 01:03:17 INFO - Directory to install application into. [default: 01:03:17 INFO - "/builds/slave/test"] 01:03:17 INFO - --app=APP Application being installed. [default: firefox] 01:03:17 INFO - mkdir: /builds/slave/test/build/application 01:03:17 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'] 01:03:17 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 01:03:34 INFO - Reading from file tmpfile_stdout 01:03:34 INFO - Output received: 01:03:34 INFO - /builds/slave/test/build/application/firefox/firefox 01:03:34 INFO - Running post-action listener: _resource_record_post_action 01:03:34 INFO - ##### 01:03:34 INFO - ##### Finished install step (success) 01:03:34 INFO - ##### 01:03:34 INFO - ##### 01:03:34 INFO - ##### Running run-tests step. 01:03:34 INFO - ##### 01:03:34 INFO - Running pre-action listener: _resource_record_pre_action 01:03:34 INFO - Running main action method: run_tests 01:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:03:34 INFO - Python 2.7.3 01:03:34 INFO - Return code: 0 01:03:34 INFO - grabbing minidump binary from tooltool 01:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:34 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 0x254f9c0>, '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 0x25508c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2550d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:03:34 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 01:03:34 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 01:03:34 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 01:03:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:03:34 INFO - Return code: 0 01:03:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:03:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:03:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:03:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:03:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:03:35 INFO - Return code: 0 01:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:03:35 INFO - Using env: {'DISPLAY': ':0', 01:03:35 INFO - 'HOME': '/home/cltbld', 01:03:35 INFO - 'LANG': 'en_US.UTF-8', 01:03:35 INFO - 'LANGUAGE': 'en_US:en', 01:03:35 INFO - 'LOGNAME': 'cltbld', 01:03:35 INFO - 'MAIL': '/var/mail/cltbld', 01:03:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:03:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:35 INFO - 'MOZ_NO_REMOTE': '1', 01:03:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:35 INFO - 'NO_EM_RESTART': '1', 01:03:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:35 INFO - 'PWD': '/builds/slave/test', 01:03:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:03:35 INFO - 'SHELL': '/bin/bash', 01:03:35 INFO - 'SHLVL': '1', 01:03:35 INFO - 'TERM': 'linux', 01:03:35 INFO - 'TMOUT': '86400', 01:03:35 INFO - 'USER': 'cltbld', 01:03:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336', 01:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:35 INFO - '_': '/tools/buildbot/bin/python'} 01:03:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:03:35 INFO - mozversion application_buildid: 20160520223047 01:03:35 INFO - mozversion application_changeset: f1f2644d34440fe38c098e323bf570e09197e51a 01:03:35 INFO - mozversion application_display_name: Nightly 01:03:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:03:35 INFO - mozversion application_name: Firefox 01:03:35 INFO - mozversion application_remotingname: firefox 01:03:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:03:35 INFO - mozversion application_vendor: Mozilla 01:03:35 INFO - mozversion application_version: 49.0a1 01:03:35 INFO - mozversion platform_buildid: 20160520223047 01:03:35 INFO - mozversion platform_changeset: f1f2644d34440fe38c098e323bf570e09197e51a 01:03:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:03:35 INFO - mozversion platform_version: 49.0a1 01:03:35 INFO - using testdate: 1463817815 01:03:35 INFO - actual date: 1463817815 01:03:35 INFO - starting webserver on 'localhost:42186' 01:03:35 INFO - SUITE-START | Running 2 tests 01:03:35 INFO - TEST-START | dromaeo_css 01:03:35 INFO - operating with platform_type : linux_ 01:03:35 INFO - Initialising browser for dromaeo_css test... 01:03:35 INFO - TEST-INFO | started process 30602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQ8Xnr/profile http://localhost:42186/getInfo.html) 01:03:41 INFO - PROCESS | 30602 | 01:03:41 INFO - PROCESS | 30602 | (process:30668): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:03:41 INFO - PROCESS | 30602 | __metrics Screen width/height:1600/1200 01:03:41 INFO - PROCESS | 30602 | colorDepth:24 01:03:41 INFO - PROCESS | 30602 | Browser inner width/height: 1024/697 01:03:41 INFO - PROCESS | 30602 | __metrics 01:03:42 ERROR - PROCESS | 30602 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 01:03:43 INFO - TEST-INFO | 30602: exit 0 01:03:43 INFO - Browser initialized. 01:03:43 INFO - Running cycle 1/1 for dromaeo_css test... 01:03:43 INFO - TEST-INFO | started process 30719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQ8Xnr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:03:45 INFO - PROCESS | 30719 | 01:03:45 INFO - PROCESS | 30719 | (process:30783): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:03:55 INFO - PROCESS | 30719 | RSS: Main: 163889152 01:03:55 INFO - PROCESS | 30719 | 01:04:44 INFO - PROCESS | 30719 | 1463817884791 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] 01:06:51 INFO - PROCESS | 30719 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42186/tests/dromaeo/cssquery-ext.html) 01:06:52 INFO - PROCESS | 30719 | RSS: Main: 166514688 01:06:52 INFO - PROCESS | 30719 | 01:09:55 INFO - PROCESS | 30719 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-ext.html (next: http://localhost:42186/tests/dromaeo/cssquery-jquery.html) 01:09:55 INFO - PROCESS | 30719 | RSS: Main: 166473728 01:09:55 INFO - PROCESS | 30719 | 01:12:57 INFO - PROCESS | 30719 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42186/tests/dromaeo/cssquery-mootools.html) 01:12:58 INFO - PROCESS | 30719 | RSS: Main: 167456768 01:12:58 INFO - PROCESS | 30719 | 01:16:00 INFO - PROCESS | 30719 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42186/tests/dromaeo/cssquery-prototype.html) 01:16:00 INFO - PROCESS | 30719 | RSS: Main: 165236736 01:16:00 INFO - PROCESS | 30719 | 01:19:03 INFO - PROCESS | 30719 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42186/tests/dromaeo/cssquery-yui.html) 01:19:03 INFO - PROCESS | 30719 | RSS: Main: 166244352 01:19:03 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | Cycle 1(1): loaded http://localhost:42186/tests/dromaeo/cssquery-yui.html (next: http://localhost:42186/tests/dromaeo/cssquery-dojo.html) 01:22:06 INFO - PROCESS | 30719 | RSS: Main: 168271872 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | __start_tp_report 01:22:06 INFO - PROCESS | 30719 | _x_x_mozilla_page_load 01:22:06 INFO - PROCESS | 30719 | _x_x_mozilla_page_load_details 01:22:06 INFO - PROCESS | 30719 | |i|pagename|runs| 01:22:06 INFO - PROCESS | 30719 | |0;dojo.html;3066.1414803854927;3082.4143412751578;3095.5975723155993;3118.438681037414;3121.8595163217637;5208.374995000596;5226.895462090761;5289.973550132248;5301.284326615906;5318.840434786953;5241.606879484035;5334.386545547253;5335.7865685372635;5350.438203988583;5426.2674538937235;4830.734309612961;4841.854744357657;4949.628777841676;4972.229304457815;5018.34761481007;748.6512424628255;4848.272759086148;5020.573251273646;5046.54581087702;5052.520010598987;4865.245886887538;4877.853664390074;4878.02439512099;4885.389326334208;4902.779374928119;4700.976495117537;4862.343583616202;4879.975600121977;4898.8538923521755;4937.777799998973;4814.1334559779225;4822.7829747661435;4848.418189817209;4858.344123543312;4861.975690121562;5256.342957130359;5328.49379308965;5364.597655175839;5375.408705042481;5420.91868621971;5703.62926409782;5739.081746920473;5823.4467725566;5823.5341172706085;5824.504917082053;5733.799317023926;5773.971130144364;5783.277090363705;5791.507721843606;5837.445442682938;5374.973125134349;5382.138857782736;5383.865403364908;5384.596155288369;5396.379416367089;5771.989901767174;5810.157527158538;5820.738066787005;5844.26946631671;5867.765289388462;5600.159976003632;5624.831255062355;5634.464725851038;5635.154726790932;5636.802711905064;5598.860028499239;5712.685802280831;5716.428357164334;5721.656700597978;5724.971375143181;5603.551715862803;5604.85987850307;5615.578831587647;5676.063449530781;5679.233303503974;5588.385277619459;5697.430256974352;5708.514776243983;5758.798442054508;5795.246617939641;4195.811188496464;4274.551172126882;4301.397804307399;4304.784760762012;4360.454943132108;3763.5483741950593;3777.225668737902;3805.1818858945458;3813.656770890633;3830.6743926766535;5427.538659213932;5433.510984011379;5435;5435.864103397446;5438.83683489496;5669.914951275734;5683.204351390808;5760.279965004374;5760.942390576124;5806.44838740319;5388.137897936312;5388.703621300788;5393.056215162331;5399.082156033483;5418.4039755626845;4771.785269662873;4794.808207671724;4796.544328288807;4802.207635740064;4821.180399332122;5801.564882633735;5811.3316968548315;5878.5003274721275;5890;5892.351841297454;5746.5977381583725;5747.195392645117;5747.74135163927;5774.1338799178775;5776.42235776419;5874.735636896265;5891.02798038336;5900.350961394157;5908.261467316585;5935.732892019783;5408.486193811582;5700.429957004267;5733.197352370755;5754.050581654147;5793.015187418233;5809.419058094157;5809.883802324014;5810.302763668386;5816.970915145397;5844.707764611838;5480.260164877691;5684.630499017716;5688.288963879515;5693.146028095819;5703.857403564944;5491.835244942658;5496.038193316073;5513.558915286687;5577.693226872561;5582.8325150245555;5356.303680521507;5357.223202635674;5427.701476418835;5453.072977593898;5498.092814685532;5586.581006424616;5598.300212473441;5628.324601047737;5641.323041235078;5658.632188907708;5386.380566234933;5442.755076021668;5453.318335208099;5477.616566840442;5529 01:22:06 INFO - PROCESS | 30719 | |1;ext.html;601.1883956658512;654.8919428294332;657.2441692054138;663.9336066393364;674.1943377663691;41630.79184604077;42258.15483690328;42287.577124228825;42426.787866060666;44351;44160.558394416046;44237;44419.555804441945;44534.10931781362;44817.103657926906;8663.39356245063;8824.117588241157;8826.73519794404;8828.779280517974;8841.38110332277;8620.396572239946;8672.60973256205;8711.695090671828;8723.345749068814;8723.781905452352;8756.518391488466;8816.250618697419;8816.823663526726;8820.382573219877;8823.382363234576;8755.693550725726;8758.649654013832;8781.912180878237;8783.34124940632;8811.823763524693;8711.695090671796;8757.649694012232;8788.472691638523;8811.427257228259;8823.073577274357;41093.79453102745;41273.1745365094;41296.79351603253;41511.584884151074;41656.79171604153;3440.415129428003;3517.6306487818924;3567.6967457766123;3686.2811751708427;3748.6438788315068;30029;30308.393832123456;30480.390392192032;32380.514292285636;32578;4243.575642435762;4373.912521749579;4493.168763778712;4536.138133754576;4540.72755634663;344708;344798;345559;345841.9999999975;347238;56545;57686;57713.71143144257;59866;60396.39603603996;62819;63356.36643633597;63400.68299658472;63455.36544634494;63755;16538.173091345383;16579.585510362336;16684.74972875408;16748.330066797436;16777.580560486087;12239.204451710788;12329.568465103857;12353.814692779615;12387.442565084593;12430.316332601613;18907.18570301609;19142.521436964187;19154;19245.518862028282;19287.589051368577;7121.400688748673;7335.303146201102;7396.408287337;7459.477836551498;7489.812754681177;1045.5556388534842;1170.0931777872217;1174.0666170394557;1195.9043276537857;1251.455616806692;32313.51529727056;32429.18927026796;32549.34901302008;32719.182020449203;33197.17007074794;1196.2642974570576;1203.061611942686;1242.3912282981455;1259.1437822280755;1269.676232560691;17002.574935626708;17110;17179.656406871793;17192.484225473258;17214.1392930353;557808;565070;566062;566098;566598;57658;59121.40878591159;59368.406315936285;59451;59483;1411.985880141206;1413.4699487692114;1421.393824977789;1446.7106578684304;1451.4702133721116;30634;32094.19764505906;32264.418846492692;32326.191845203117;32336;51423.48576514336;51525;51576;51698.483015170874;51956.74021629868;459841;462000;462851;463591;464348;25559;25623.615645764956;27795.722042779315;27940.44119117647;28028;48719.51280487292;48852;49175.75412122916;49662.25506617476;49688.75155624199;40305;41431;41792.582074180085;41929.79035104805;42159.578404215565;39990.40014399844;40546.1890762189;40759.38860917148;41502.1699566001;41794.1641167181;40925.38611920883;41227.38158927559;41367;41415;44241.115177695625;34721.305573887876;38159.23681526409;38268.42597360986;38400.423993640674;38731.80634096924;28745.712542874302;28820.567691484226;28988.42023159567;28994.27514312159;29195.41609167847 01:22:06 INFO - PROCESS | 30719 | |2;jquery.html;398.8225239768303;400.0798164222288;401.24966312994707;401.2977289742946;419.2579134931172;13649.590512284623;17814.910925445372;18343.08284585772;19081.23675052998;19171.329003484865;16732.498025059267;17019.40432084877;17259;17980.820191798077;18108.275668973227;5421.1326187809955;5451.754671039793;5595.7481913313795;5635.6618602883955;5659.801906933259;5543.972280138593;5548.889022219553;5568.52667523261;5581.3302403711405;5590.385057643676;5353.5984801139875;5534.446555344473;5538.47384498472;5540.833774986757;5592.217089607459;5513.283273174462;5544.500994910478;5565.276514053167;5582.469665381803;5589.0219211637805;4818.542238487338;4974.651774375795;4975.154223781966;5001.9749901250625;5007.048660754445;21226.257081002244;22194.556108877732;22223.333300000864;22279.220227292128;22641;2130.1585873579847;2251.718535183102;2268.2401395532515;2355.211004313557;2358.481134150484;13687.726245475034;14051.227182504957;14106.85893141076;14203.360848761831;14249.50126745559;1992.4919145617775;2042.3056160905214;2051.989740051305;2053.897305134752;2059.660156074246;66512.3348766511;71735.64132179305;73284;77830.22169778343;77909.61045194737;9830.655927042519;10301.845472317922;10495.953289108704;10667.466626668636;10683.732906677395;14261.572152835432;14276;14331.140131592138;14359.569212923629;14360.348559915534;7830.921690783133;8193.590320483952;8266.338692904554;8300.667973281;8395.286400656012;8203.630836612367;8216;8274.29668478174;8324.29243514296;8451.281641060456;6392.552521323462;6460.580062295936;6466.902996455057;6550.312217217219;6565.080888675589;1876.2155359798714;1924.5669724311917;1926.402815127315;1943.3392646500258;1965.8132477414622;938.4556956964944;976.5215044628223;980.6371642492181;1020.5611587017654;1045.29442626227;17151.57121071983;18376.724349134773;18766;19065;19136.330228442217;1037.4138611684375;1039.594558122333;1058.666520046183;1063.0273299930632;1097.2154909239932;10529.262951593468;10968;10971.83542246867;11079.612213572485;11084.224104312621;454314;461155;483587;485778;485917;79693;83693.58153209195;83747.58126209452;83790;83962;1034.5913364221242;1056.4242487844144;1056.4400867540062;1070.7751372211767;1078.7734575739182;16807.831921681114;16816.915915420344;17016.48950531486;17269.39557115495;17346.21942012587;36294.63705362913;36993;37376.43935340918;38614.2277154461;38985.41521877231;50079.24881126859;51121.7443912778;51701.48298516967;52572.474275256754;52977.7351113242;7947;8120.593970301343;8218.096009438837;8223.629936652984;8287.046989596274;12100.515979360727;12148.271103733805;12260.877391225973;12380.566680166152;12400.441980110736;10534.841977370192;10912.945435272773;11100.944495277472;11115.166362522681;11197.440127993405;10729.731756706145;10739.301945373525;10845.24083314192;10937.179711521827;11062.723431913944;10404.271700980858;10519.474026298501;10807;10825.025747682746;11098.112151027737;7802.492837965514;7885.842283154419;7938.364930805406;8026.8394632105865;8084.7574572762915;10715.089217416295;11339.886601133883;11486.310821350746;11720.355380454157;11745 01:22:06 INFO - PROCESS | 30719 | |3;mootools.html;1511.8563736445037;1519.0202319503917;1716.2620073368455;1800.1629242402296;1824.0697244405358;8110.9861267341585;8696.21734043936;8779.824403511933;9422.811543769129;9427.575759090849;8778.297736181106;9058.365914385995;9078.682246121387;9131.2238459731;9147.496887671176;2297.563462942044;2320.628699408095;2323.6398358254414;2330.4406942333803;2333.3583264602285;2233.765454627265;2245.315178870444;2260.819134469247;2275.5335156293004;2276.237460450751;2230.29745630126;2275.4425165834396;2284.0292875527916;2323.8954247058923;2340.941476463085;2182.552576721776;2222.822174226066;2232.6316157833858;2233.7542870284256;2245.1692873636694;2345.319857241398;2347;2367.112332875172;2369.893354799038;2376.607859703147;9003.14470125337;9022.097790220925;9104.36269461138;9105.499197544132;9117.908820911773;4980.676256043345;5084.720340381277;5124.538791508745;5124.8206312778875;5126.974365128188;3134.6865313468697;3179.2210908327606;3352.8658853645825;3366.461366181399;3367.3938691035605;1004.1364426593124;1031;1035.2753072848961;1043.2540733375672;1052.8736551613779;12831;12868.806967895489;12878.034147438886;12883.67790805228;12976.87023129766;4694.570686181932;4791.305260737174;4833.3958255218095;4860.756962151878;4865.148598995162;10881.83677244842;10899.891001090045;10944.507497162647;10946;10950.561977520969;5247.868803279948;5279.683219006872;5281.075811733008;5281.788728450819;5290.761915713802;4254.957450425456;4603.700759450625;4628.490866004737;4756.833510827105;4759.4764575896625;4124.773137477468;4134.338505839051;4137.179640957969;4161.10536234711;4161.271777438936;1304.067591671959;1304.9478020879249;1312.0749871340681;1317.7298653776145;1328.7010422655019;967.7000129959595;1061.8035663402295;1068.6740544134113;1070.4487189097622;1075.0593230922943;6237.438630523275;6462.32145624712;6509.153810004764;6510.121133646991;6531;430.8922769307673;434.5372178629812;439.9670024748157;452.0552046223409;452.66955122759913;4336.588024137702;4358.782060896942;4373.934390984138;4398.582134697199;4429.557044295545;11111.444427778579;11482.655520334403;11534.307941523535;11562.07503399726;11570.710732231762;11343.773124537463;11401.600943966921;11417.771644567061;11428.828567571492;11430.657080287605;8133.4306598538715;8485.830283394298;8504.617292221865;8610.655573777103;8611.483311001235;6167.907481387693;6324.747010119544;6398.104265402941;6501.674916254074;6546.574472659262;10335.534900929626;10505.842412363667;10595.152387808803;10666.466676665981;10725;10495.212859035755;10534;10560.577576896838;10717.249792514762;10727;7643.159252482334;8368.916310837058;8643.438176518506;8735.91264087351;8848.247898928663;9002.684906028258;9037.141471560191;9043.457392556467;9071.455712657262;9091.59087841062;7823.687052517836;7940.920590794018;8010.319122874621;8051.1546287641295;8169.264766170835;7689.423293252917;7689.923100769144;7772.533647981139;7830.373570114263;7873.881891771513;6920.134983127109;7215.134183897966;7285.453590980592;7338.559686418832;7349.191588925107;5434.2935418395355;5445.829146733471;5511.889762204653;5577.9442205577425;5732.283464566929;5488.9725551371985;5492.5605951524585;5530.695811730233;5639.3232812062815;5666.235058267246 01:22:06 INFO - PROCESS | 30719 | |4;prototype.html;331.1935437210393;331.89545293232635;333.7380156577087;336.78950655840083;337.7838183562519;5625.156226566017;5641.18202860585;5652.604317697757;5665.461781130791;5673.744681489333;5556.16657501375;5562.249096371998;5586.217929489874;5615.719214039292;5639.492445679888;4110.917781644365;4194.286971214886;4340.327249276367;4343.739375637456;4344.391785150082;4306.483222013363;4325.026868954492;4334.501532323791;4349.434573505456;4393.956060439386;4281.571842815709;4302.677299202556;4304.5910638489295;4316.892077698051;4331.548931108083;4148.91702165958;4284.485861696585;4307.784610769449;4320.978395108004;4342.652587792984;3755.9483344663263;3767.2277183177384;3771.5662698789715;3785.6592906638534;3788.29916465452;5333.146696528575;5433;5441.2654291670515;5447.945520544784;5458.699771512565;4774.7135171889795;4880.243562247857;4901.240307752304;4915.115279249733;4991.650584459089;5759.913601295942;5769.451902069339;5798.681072541009;5811.564132690065;5842.561807864385;4130.070734084837;4139.937900931458;4153.673942592158;4154.5222299435345;4160.54234034256;5884.823455296348;6076.118962750376;6169.383061693839;6187.504999600066;6211.906821397728;4185.309423945076;4194.573844892751;4229.767362795014;4233.280342341748;4259.574042595716;4230.280852255124;4247.00195454068;4275.957240427556;4288.421063156434;4295.742255464682;4754.738489383048;4885.877853053631;4905.435874874363;4910.48439913811;4968.757810547363;5850.297964244318;5872.706364681749;5883.382244864228;5889.499392551681;5929.762809487572;1467.1710483576744;1488.977665335021;1493.2981498695597;1496.2593516209329;1500.5423345879612;939.2532936315646;953.50894289441;970.0687340153531;989.6288891665625;1002.2132625888788;5524.861878453071;5585.888282234414;5599.496045355856;5603.103503439512;5612.410696876851;5967.283925928917;5998.670073145931;6001.759929602855;6015.646479542155;6063.363346848518;5501.119820828648;5516.365617953907;5621.718914054362;5634.7182640867795;5637.605367624227;3192;3219.6780321967617;3264.9347013059605;3290.3254832759226;3302.3230237801195;5888.381719919433;6241.21984751906;6248.843778905563;6261.436470717657;6318.684065796691;6031.909521357183;6082.726277317532;6102.511799056065;6142.938570614326;6174.722137503823;6230.190075290274;6253.5622506425025;6272.780452684134;6299.149614802126;6333.050042493571;5829.795957141479;5943.989521781394;6057;6070.484008859296;6076.116403914801;5930.458080899084;5964.419428851271;5967.164596956516;5972.193753843176;5972.522198224218;6018.578699490994;6242.28213755424;6248.625082495065;6267.088537995955;6285.214348206474;4239.59723826236;4258.659307255474;4258.808353624157;4265.21093597673;4267.445232119929;5981.401859813984;6005.969970150121;6025.216721826135;6045.576809623284;6058.7273572688455;5645.830625081254;5815.2149459822385;5836.212111364912;5844.15259787337;5844.415558444121;5766.250387449605;5776.277965254343;5828.125781132864;5883.264591926009;5892.616979896293;5169.61227907916;5698.743556539883;5711.171880077449;5723.771049157987;5739.770409183586;5799.710014499343;5858.326292476249;5883.646981181143;5885.792827689616;5935.525157987437;5733.369329373849;5776.42235776419;5783.248177736868;5846.678432686073;5869.236999190078 01:22:06 INFO - PROCESS | 30719 | |5;yui.html;763.5723994563042;800.2917418084995;815.0438946528335;824.9010118785744;828.6022709099632;14086.295685215737;15045.774313385295;15075.246237688127;15118.092914425142;15223.695526089485;13834.100783449068;13868.653283667913;13870;13893.513727019556;13935.37290821913;673.9561928474634;796.2157275084038;807.1645846548838;818.5088946632033;821.9589020548949;814.914433984429;818.3657665309403;819.0908092017855;819.1685439279107;819.2381085590398;860.084010528788;864.5979619476973;865.6061492021115;866.644675682967;867.657275376226;850.783050322167;851.535912927456;851.6848765956605;852.1606217875387;852.9744107676779;626.1265534579281;628.5317438508295;628.6510986402545;629.1663545801786;629.9401556852092;14056.85943140576;14141.929290353586;14160.575182744535;14161.504347347896;14168.220747858864;13991.58025259244;14030.228337441436;14061.367238474191;14227.21750303733;14259.358328875225;11394;11587.652370428901;11694.883051169465;11706.707332316675;11776.11679124069;3858.6141385861188;3881.7670939743425;3952.822123004472;3977.085270387827;4036.4752582164133;55060;55102.44897551013;55206.17190742142;55597;55991.72004139994;10978.945105274583;11004.889951100547;11101.83347249792;11138.108951283877;11398.94300528492;20051.598968020557;20098.39704808858;20159.798402015793;20206;20299.898500507697;8197.631106600218;8205.548694821842;8273.924389829404;8537.146285371413;8553.743387698254;4602.976985115053;4607.124646317189;4624.329472226508;4627.8843028923875;4824.782884770194;3182.7612929030415;3268.3299923515624;3271.8200498972783;3273.2307907641684;3277.524758909945;600.2017316968421;612.6967151260154;616.9321374648785;617.2161355079024;629.3926361061598;648.0441349010172;658.9439897608661;727.1492353945896;750.5271678842404;755.7354925775934;9222.354435189472;9658.661946831828;9659.661911833053;9787.804243915081;9814.558344874498;741.9698358057364;768.4582369429651;770.9074911010715;785.7996210966166;801.6552882260684;4212.304969679968;4303.761082779464;4406.82533899618;4486.170058539181;4533.909321813545;58116;72790.63604681943;72822.63588682022;72966;73272.63363683148;53682.7315863426;56711;57164.14253786197;57978.420215797305;59546;54387;54568.727156363966;54990.725046374515;55448.44551554433;56055;9538.475383853676;9657.46883921391;9673.758156046155;9700.660476883275;9765.072318129767;35374.46938295979;35799.46300805438;36104.63895361118;36364.45453318255;36505.976513875976;46714;48158.759206203744;48626;48669.2699609499;48855.75572122259;11505.712357191138;12288.877111228774;12308.630741077783;12689.492420303084;12927.224366538037;13273.203607783564;13332.143494556765;13767.173969561858;14045.08706934046;14600.926995364955;12962.675933101747;13104.344782761014;13157.60527184186;13231.536896208587;13748.65628359299;12070;12103.757924841279;12141.332226727614;12377.443015064164;12397.318147501974;12587.93706031464;12615.621531354074;12919.289439080942;13065;13556.186628802303;10453.320534165256;10568;10715.732106697395;10951.945240273748;11001.724956876142;10813.134949204203;11044.116470682487;11188.384638844942;11243.381614011309;11261.380624065427 01:22:06 INFO - PROCESS | 30719 | __end_tp_report 01:22:06 INFO - PROCESS | 30719 | __start_cc_report 01:22:06 INFO - PROCESS | 30719 | _x_x_mozilla_cycle_collect,347 01:22:06 INFO - PROCESS | 30719 | __end_cc_report 01:22:06 INFO - PROCESS | 30719 | __startTimestamp1463818926822__endTimestamp 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | ------- Summary: start ------- 01:22:06 INFO - PROCESS | 30719 | Number of tests: 6 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | [#0] dojo.html Cycles:165 Average:5281.27 Median:5477.62 stddev:709.86 (13.0%) stddev-sans-first:690.44 01:22:06 INFO - PROCESS | 30719 | Values: 3066.1 3082.4 3095.6 3118.4 3121.9 5208.4 5226.9 5290.0 5301.3 5318.8 5241.6 5334.4 5335.8 5350.4 5426.3 4830.7 4841.9 4949.6 4972.2 5018.3 748.7 4848.3 5020.6 5046.5 5052.5 4865.2 4877.9 4878.0 4885.4 4902.8 4701.0 4862.3 4880.0 4898.9 4937.8 4814.1 4822.8 4848.4 4858.3 4862.0 5256.3 5328.5 5364.6 5375.4 5420.9 5703.6 5739.1 5823.4 5823.5 5824.5 5733.8 5774.0 5783.3 5791.5 5837.4 5375.0 5382.1 5383.9 5384.6 5396.4 5772.0 5810.2 5820.7 5844.3 5867.8 5600.2 5624.8 5634.5 5635.2 5636.8 5598.9 5712.7 5716.4 5721.7 5725.0 5603.6 5604.9 5615.6 5676.1 5679.2 5588.4 5697.4 5708.5 5758.8 5795.2 4195.8 4274.6 4301.4 4304.8 4360.5 3763.5 3777.2 3805.2 3813.7 3830.7 5427.5 5433.5 5435.0 5435.9 5438.8 5669.9 5683.2 5760.3 5760.9 5806.4 5388.1 5388.7 5393.1 5399.1 5418.4 4771.8 4794.8 4796.5 4802.2 4821.2 5801.6 5811.3 5878.5 5890.0 5892.4 5746.6 5747.2 5747.7 5774.1 5776.4 5874.7 5891.0 5900.4 5908.3 5935.7 5408.5 5700.4 5733.2 5754.1 5793.0 5809.4 5809.9 5810.3 5817.0 5844.7 5480.3 5684.6 5688.3 5693.1 5703.9 5491.8 5496.0 5513.6 5577.7 5582.8 5356.3 5357.2 5427.7 5453.1 5498.1 5586.6 5598.3 5628.3 5641.3 5658.6 5386.4 5442.8 5453.3 5477.6 5529.0 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | [#1] ext.html Cycles:180 Average:61810.17 Median:41724.69 stddev:123790.21 (296.7%) stddev-sans-first:124052.17 01:22:06 INFO - PROCESS | 30719 | Values: 601.2 654.9 657.2 663.9 674.2 41630.8 42258.2 42287.6 42426.8 44351.0 44160.6 44237.0 44419.6 44534.1 44817.1 8663.4 8824.1 8826.7 8828.8 8841.4 8620.4 8672.6 8711.7 8723.3 8723.8 8756.5 8816.3 8816.8 8820.4 8823.4 8755.7 8758.6 8781.9 8783.3 8811.8 8711.7 8757.6 8788.5 8811.4 8823.1 41093.8 41273.2 41296.8 41511.6 41656.8 3440.4 3517.6 3567.7 3686.3 3748.6 30029.0 30308.4 30480.4 32380.5 32578.0 4243.6 4373.9 4493.2 4536.1 4540.7 344708.0 344798.0 345559.0 345842.0 347238.0 56545.0 57686.0 57713.7 59866.0 60396.4 62819.0 63356.4 63400.7 63455.4 63755.0 16538.2 16579.6 16684.7 16748.3 16777.6 12239.2 12329.6 12353.8 12387.4 12430.3 18907.2 19142.5 19154.0 19245.5 19287.6 7121.4 7335.3 7396.4 7459.5 7489.8 1045.6 1170.1 1174.1 1195.9 1251.5 32313.5 32429.2 32549.3 32719.2 33197.2 1196.3 1203.1 1242.4 1259.1 1269.7 17002.6 17110.0 17179.7 17192.5 17214.1 557808.0 565070.0 566062.0 566098.0 566598.0 57658.0 59121.4 59368.4 59451.0 59483.0 1412.0 1413.5 1421.4 1446.7 1451.5 30634.0 32094.2 32264.4 32326.2 32336.0 51423.5 51525.0 51576.0 51698.5 51956.7 459841.0 462000.0 462851.0 463591.0 464348.0 25559.0 25623.6 27795.7 27940.4 28028.0 48719.5 48852.0 49175.8 49662.3 49688.8 40305.0 41431.0 41792.6 41929.8 42159.6 39990.4 40546.2 40759.4 41502.2 41794.2 40925.4 41227.4 41367.0 41415.0 44241.1 34721.3 38159.2 38268.4 38400.4 38731.8 28745.7 28820.6 28988.4 28994.3 29195.4 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | [#2] jquery.html Cycles:180 Average:27625.89 Median:12265.47 stddev:77926.89 (635.3%) stddev-sans-first:78118.68 01:22:06 INFO - PROCESS | 30719 | Values: 398.8 400.1 401.2 401.3 419.3 13649.6 17814.9 18343.1 19081.2 19171.3 16732.5 17019.4 17259.0 17980.8 18108.3 5421.1 5451.8 5595.7 5635.7 5659.8 5544.0 5548.9 5568.5 5581.3 5590.4 5353.6 5534.4 5538.5 5540.8 5592.2 5513.3 5544.5 5565.3 5582.5 5589.0 4818.5 4974.7 4975.2 5002.0 5007.0 21226.3 22194.6 22223.3 22279.2 22641.0 2130.2 2251.7 2268.2 2355.2 2358.5 13687.7 14051.2 14106.9 14203.4 14249.5 1992.5 2042.3 2052.0 2053.9 2059.7 66512.3 71735.6 73284.0 77830.2 77909.6 9830.7 10301.8 10496.0 10667.5 10683.7 14261.6 14276.0 14331.1 14359.6 14360.3 7830.9 8193.6 8266.3 8300.7 8395.3 8203.6 8216.0 8274.3 8324.3 8451.3 6392.6 6460.6 6466.9 6550.3 6565.1 1876.2 1924.6 1926.4 1943.3 1965.8 938.5 976.5 980.6 1020.6 1045.3 17151.6 18376.7 18766.0 19065.0 19136.3 1037.4 1039.6 1058.7 1063.0 1097.2 10529.3 10968.0 10971.8 11079.6 11084.2 454314.0 461155.0 483587.0 485778.0 485917.0 79693.0 83693.6 83747.6 83790.0 83962.0 1034.6 1056.4 1056.4 1070.8 1078.8 16807.8 16816.9 17016.5 17269.4 17346.2 36294.6 36993.0 37376.4 38614.2 38985.4 50079.2 51121.7 51701.5 52572.5 52977.7 7947.0 8120.6 8218.1 8223.6 8287.0 12100.5 12148.3 12260.9 12380.6 12400.4 10534.8 10912.9 11100.9 11115.2 11197.4 10729.7 10739.3 10845.2 10937.2 11062.7 10404.3 10519.5 10807.0 10825.0 11098.1 7802.5 7885.8 7938.4 8026.8 8084.8 10715.1 11339.9 11486.3 11720.4 11745.0 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | [#3] mootools.html Cycles:180 Average:6007.86 Median:2419.27 stddev:3501.48 (144.7%) stddev-sans-first:3495.00 01:22:06 INFO - PROCESS | 30719 | Values: 1511.9 1519.0 1716.3 1800.2 1824.1 8111.0 8696.2 8779.8 9422.8 9427.6 8778.3 9058.4 9078.7 9131.2 9147.5 2297.6 2320.6 2323.6 2330.4 2333.4 2233.8 2245.3 2260.8 2275.5 2276.2 2230.3 2275.4 2284.0 2323.9 2340.9 2182.6 2222.8 2232.6 2233.8 2245.2 2345.3 2347.0 2367.1 2369.9 2376.6 9003.1 9022.1 9104.4 9105.5 9117.9 4980.7 5084.7 5124.5 5124.8 5127.0 3134.7 3179.2 3352.9 3366.5 3367.4 1004.1 1031.0 1035.3 1043.3 1052.9 12831.0 12868.8 12878.0 12883.7 12976.9 4694.6 4791.3 4833.4 4860.8 4865.1 10881.8 10899.9 10944.5 10946.0 10950.6 5247.9 5279.7 5281.1 5281.8 5290.8 4255.0 4603.7 4628.5 4756.8 4759.5 4124.8 4134.3 4137.2 4161.1 4161.3 1304.1 1304.9 1312.1 1317.7 1328.7 967.7 1061.8 1068.7 1070.4 1075.1 6237.4 6462.3 6509.2 6510.1 6531.0 430.9 434.5 440.0 452.1 452.7 4336.6 4358.8 4373.9 4398.6 4429.6 11111.4 11482.7 11534.3 11562.1 11570.7 11343.8 11401.6 11417.8 11428.8 11430.7 8133.4 8485.8 8504.6 8610.7 8611.5 6167.9 6324.7 6398.1 6501.7 6546.6 10335.5 10505.8 10595.2 10666.5 10725.0 10495.2 10534.0 10560.6 10717.2 10727.0 7643.2 8368.9 8643.4 8735.9 8848.2 9002.7 9037.1 9043.5 9071.5 9091.6 7823.7 7940.9 8010.3 8051.2 8169.3 7689.4 7689.9 7772.5 7830.4 7873.9 6920.1 7215.1 7285.5 7338.6 7349.2 5434.3 5445.8 5511.9 5577.9 5732.3 5489.0 5492.6 5530.7 5639.3 5666.2 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | [#4] prototype.html Cycles:180 Average:4916.66 Median:5636.16 stddev:1459.99 (25.9%) stddev-sans-first:1422.94 01:22:06 INFO - PROCESS | 30719 | Values: 331.2 331.9 333.7 336.8 337.8 5625.2 5641.2 5652.6 5665.5 5673.7 5556.2 5562.2 5586.2 5615.7 5639.5 4110.9 4194.3 4340.3 4343.7 4344.4 4306.5 4325.0 4334.5 4349.4 4394.0 4281.6 4302.7 4304.6 4316.9 4331.5 4148.9 4284.5 4307.8 4321.0 4342.7 3755.9 3767.2 3771.6 3785.7 3788.3 5333.1 5433.0 5441.3 5447.9 5458.7 4774.7 4880.2 4901.2 4915.1 4991.7 5759.9 5769.5 5798.7 5811.6 5842.6 4130.1 4139.9 4153.7 4154.5 4160.5 5884.8 6076.1 6169.4 6187.5 6211.9 4185.3 4194.6 4229.8 4233.3 4259.6 4230.3 4247.0 4276.0 4288.4 4295.7 4754.7 4885.9 4905.4 4910.5 4968.8 5850.3 5872.7 5883.4 5889.5 5929.8 1467.2 1489.0 1493.3 1496.3 1500.5 939.3 953.5 970.1 989.6 1002.2 5524.9 5585.9 5599.5 5603.1 5612.4 5967.3 5998.7 6001.8 6015.6 6063.4 5501.1 5516.4 5621.7 5634.7 5637.6 3192.0 3219.7 3264.9 3290.3 3302.3 5888.4 6241.2 6248.8 6261.4 6318.7 6031.9 6082.7 6102.5 6142.9 6174.7 6230.2 6253.6 6272.8 6299.1 6333.1 5829.8 5944.0 6057.0 6070.5 6076.1 5930.5 5964.4 5967.2 5972.2 5972.5 6018.6 6242.3 6248.6 6267.1 6285.2 4239.6 4258.7 4258.8 4265.2 4267.4 5981.4 6006.0 6025.2 6045.6 6058.7 5645.8 5815.2 5836.2 5844.2 5844.4 5766.3 5776.3 5828.1 5883.3 5892.6 5169.6 5698.7 5711.2 5723.8 5739.8 5799.7 5858.3 5883.6 5885.8 5935.5 5733.4 5776.4 5783.2 5846.7 5869.2 01:22:06 INFO - PROCESS | 30719 | 01:22:06 INFO - PROCESS | 30719 | [#5] yui.html Cycles:180 Average:15523.14 Median:4605.05 stddev:18402.22 (399.6%) stddev-sans-first:18420.46 01:22:06 INFO - PROCESS | 30719 | Values: 763.6 800.3 815.0 824.9 828.6 14086.3 15045.8 15075.2 15118.1 15223.7 13834.1 13868.7 13870.0 13893.5 13935.4 674.0 796.2 807.2 818.5 822.0 814.9 818.4 819.1 819.2 819.2 860.1 864.6 865.6 866.6 867.7 850.8 851.5 851.7 852.2 853.0 626.1 628.5 628.7 629.2 629.9 14056.9 14141.9 14160.6 14161.5 14168.2 13991.6 14030.2 14061.4 14227.2 14259.4 11394.0 11587.7 11694.9 11706.7 11776.1 3858.6 3881.8 3952.8 3977.1 4036.5 55060.0 55102.4 55206.2 55597.0 55991.7 10978.9 11004.9 11101.8 11138.1 11398.9 20051.6 20098.4 20159.8 20206.0 20299.9 8197.6 8205.5 8273.9 8537.1 8553.7 4603.0 4607.1 4624.3 4627.9 4824.8 3182.8 3268.3 3271.8 3273.2 3277.5 600.2 612.7 616.9 617.2 629.4 648.0 658.9 727.1 750.5 755.7 9222.4 9658.7 9659.7 9787.8 9814.6 742.0 768.5 770.9 785.8 801.7 4212.3 4303.8 4406.8 4486.2 4533.9 58116.0 72790.6 72822.6 72966.0 73272.6 53682.7 56711.0 57164.1 57978.4 59546.0 54387.0 54568.7 54990.7 55448.4 56055.0 9538.5 9657.5 9673.8 9700.7 9765.1 35374.5 35799.5 36104.6 36364.5 36506.0 46714.0 48158.8 48626.0 48669.3 48855.8 11505.7 12288.9 12308.6 12689.5 12927.2 13273.2 13332.1 13767.2 14045.1 14600.9 12962.7 13104.3 13157.6 13231.5 13748.7 12070.0 12103.8 12141.3 12377.4 12397.3 12587.9 12615.6 12919.3 13065.0 13556.2 10453.3 10568.0 10715.7 10951.9 11001.7 10813.1 11044.1 11188.4 11243.4 11261.4 01:22:06 INFO - PROCESS | 30719 | -------- Summary: end -------- 01:22:06 INFO - PROCESS | 30719 | 01:22:07 INFO - PROCESS | 30719 | 01:22:07 INFO - PROCESS | 30719 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 01:22:07 INFO - PROCESS | 30719 | 01:22:07 INFO - PROCESS | 30719 | 01:22:07 INFO - PROCESS | 30719 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 01:22:07 INFO - PROCESS | 30719 | 01:22:07 INFO - TEST-INFO | 30719: exit 0 01:22:07 INFO - TEST-OK | dromaeo_css | took 1112043ms 01:22:07 INFO - TEST-START | kraken 01:22:07 INFO - operating with platform_type : linux_ 01:22:07 INFO - Initialising browser for kraken test... 01:22:07 INFO - TEST-INFO | started process 30958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEFzHBP/profile http://localhost:42186/getInfo.html) 01:22:11 INFO - PROCESS | 30958 | 01:22:11 INFO - PROCESS | 30958 | (process:31027): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:22:12 INFO - PROCESS | 30958 | __metrics Screen width/height:1600/1200 01:22:12 INFO - PROCESS | 30958 | colorDepth:24 01:22:12 INFO - PROCESS | 30958 | Browser inner width/height: 1024/697 01:22:12 INFO - PROCESS | 30958 | __metrics 01:22:12 ERROR - PROCESS | 30958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 01:22:13 INFO - TEST-INFO | 30958: exit 0 01:22:13 INFO - Browser initialized. 01:22:13 INFO - Running cycle 1/1 for kraken test... 01:22:13 INFO - TEST-INFO | started process 31078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEFzHBP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:15 INFO - PROCESS | 31078 | 01:22:15 INFO - PROCESS | 31078 | (process:31139): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:22:25 INFO - PROCESS | 31078 | RSS: Main: 164642816 01:22:25 INFO - PROCESS | 31078 | 01:22:28 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-beat-detection) 01:22:29 INFO - PROCESS | 31078 | RSS: Main: 169312256 01:22:29 INFO - PROCESS | 31078 | 01:22:31 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-dft) 01:22:32 INFO - PROCESS | 31078 | RSS: Main: 169410560 01:22:32 INFO - PROCESS | 31078 | 01:22:35 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-fft) 01:22:35 INFO - PROCESS | 31078 | RSS: Main: 163958784 01:22:35 INFO - PROCESS | 31078 | 01:22:38 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42186/tests/kraken/driver.html?testName=audio-oscillator) 01:22:38 INFO - PROCESS | 31078 | RSS: Main: 164651008 01:22:38 INFO - PROCESS | 31078 | 01:22:41 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42186/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:22:41 INFO - PROCESS | 31078 | RSS: Main: 164282368 01:22:41 INFO - PROCESS | 31078 | 01:22:44 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42186/tests/kraken/driver.html?testName=imaging-darkroom) 01:22:45 INFO - PROCESS | 31078 | RSS: Main: 164388864 01:22:45 INFO - PROCESS | 31078 | 01:22:48 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42186/tests/kraken/driver.html?testName=imaging-desaturate) 01:22:49 INFO - PROCESS | 31078 | RSS: Main: 163024896 01:22:49 INFO - PROCESS | 31078 | 01:22:52 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42186/tests/kraken/driver.html?testName=json-parse-financial) 01:22:53 INFO - PROCESS | 31078 | RSS: Main: 164564992 01:22:53 INFO - PROCESS | 31078 | 01:22:54 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42186/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:22:55 INFO - PROCESS | 31078 | RSS: Main: 164306944 01:22:55 INFO - PROCESS | 31078 | 01:22:57 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:22:57 INFO - PROCESS | 31078 | RSS: Main: 164618240 01:22:57 INFO - PROCESS | 31078 | 01:22:59 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:23:00 INFO - PROCESS | 31078 | RSS: Main: 164483072 01:23:00 INFO - PROCESS | 31078 | 01:23:03 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:23:03 INFO - PROCESS | 31078 | RSS: Main: 164855808 01:23:03 INFO - PROCESS | 31078 | 01:23:06 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:23:07 INFO - PROCESS | 31078 | RSS: Main: 164794368 01:23:07 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | Cycle 1(1): loaded http://localhost:42186/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42186/tests/kraken/driver.html?testName=ai-astar) 01:23:09 INFO - PROCESS | 31078 | RSS: Main: 165965824 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | __start_tp_report 01:23:09 INFO - PROCESS | 31078 | _x_x_mozilla_page_load 01:23:09 INFO - PROCESS | 31078 | _x_x_mozilla_page_load_details 01:23:09 INFO - PROCESS | 31078 | |i|pagename|runs| 01:23:09 INFO - PROCESS | 31078 | |0;ai-astar;109;104;110;111;110;113;110;111;115;110 01:23:09 INFO - PROCESS | 31078 | |1;audio-beat-detection;151;125;154;206;126;149;154;127;175;127 01:23:09 INFO - PROCESS | 31078 | |2;audio-dft;162;162;162;162;165;176;163;173;162;161 01:23:09 INFO - PROCESS | 31078 | |3;audio-fft;74;73;76;166;75;75;76;73;176;74 01:23:09 INFO - PROCESS | 31078 | |4;audio-oscillator;91;91;172;93;94;93;144;93;93;138 01:23:09 INFO - PROCESS | 31078 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;117;118;118 01:23:09 INFO - PROCESS | 31078 | |6;imaging-darkroom;147;145;147;147;146;146;146;148;148;145 01:23:09 INFO - PROCESS | 31078 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 01:23:09 INFO - PROCESS | 31078 | |8;json-parse-financial;62;58;56;56;60;57;58;106;55;59 01:23:09 INFO - PROCESS | 31078 | |9;json-stringify-tinderbox;62;75;62;63;62;60;61;61;61;62 01:23:09 INFO - PROCESS | 31078 | |10;stanford-crypto-aes;79;78;78;78;79;79;80;79;78;81 01:23:09 INFO - PROCESS | 31078 | |11;stanford-crypto-ccm;129;128;119;140;118;121;123;128;191;129 01:23:09 INFO - PROCESS | 31078 | |12;stanford-crypto-pbkdf2;163;165;167;161;166;160;160;167;164;164 01:23:09 INFO - PROCESS | 31078 | |13;stanford-crypto-sha256-iterative;61;63;63;62;64;64;65;63;62;63 01:23:09 INFO - PROCESS | 31078 | __end_tp_report 01:23:09 INFO - PROCESS | 31078 | __start_cc_report 01:23:09 INFO - PROCESS | 31078 | _x_x_mozilla_cycle_collect,853 01:23:09 INFO - PROCESS | 31078 | __end_cc_report 01:23:09 INFO - PROCESS | 31078 | __startTimestamp1463818989338__endTimestamp 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | ------- Summary: start ------- 01:23:09 INFO - PROCESS | 31078 | Number of tests: 14 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:2.83 (2.6%) stddev-sans-first:2.96 01:23:09 INFO - PROCESS | 31078 | Values: 109.0 104.0 110.0 111.0 110.0 113.0 110.0 111.0 115.0 110.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:152.50 stddev:25.93 (17.0%) stddev-sans-first:27.49 01:23:09 INFO - PROCESS | 31078 | Values: 151.0 125.0 154.0 206.0 126.0 149.0 154.0 127.0 175.0 127.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#2] audio-dft Cycles:10 Average:164.80 Median:162.50 stddev:5.27 (3.2%) stddev-sans-first:5.49 01:23:09 INFO - PROCESS | 31078 | Values: 162.0 162.0 162.0 162.0 165.0 176.0 163.0 173.0 162.0 161.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#3] audio-fft Cycles:10 Average:93.80 Median:74.50 stddev:40.77 (54.7%) stddev-sans-first:42.61 01:23:09 INFO - PROCESS | 31078 | Values: 74.0 73.0 76.0 166.0 75.0 75.0 76.0 73.0 176.0 74.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:93.00 stddev:29.66 (31.9%) stddev-sans-first:30.63 01:23:09 INFO - PROCESS | 31078 | Values: 91.0 91.0 172.0 93.0 94.0 93.0 144.0 93.0 93.0 138.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:23:09 INFO - PROCESS | 31078 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 01:23:09 INFO - PROCESS | 31078 | Values: 147.0 145.0 147.0 147.0 146.0 146.0 146.0 148.0 148.0 145.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:23:09 INFO - PROCESS | 31078 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:58.00 stddev:15.36 (26.5%) stddev-sans-first:16.28 01:23:09 INFO - PROCESS | 31078 | Values: 62.0 58.0 56.0 56.0 60.0 57.0 58.0 106.0 55.0 59.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.00 stddev:4.33 (7.0%) stddev-sans-first:4.58 01:23:09 INFO - PROCESS | 31078 | Values: 62.0 75.0 62.0 63.0 62.0 60.0 61.0 61.0 61.0 62.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 01:23:09 INFO - PROCESS | 31078 | Values: 79.0 78.0 78.0 78.0 79.0 79.0 80.0 79.0 78.0 81.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:128.50 stddev:21.50 (16.7%) stddev-sans-first:22.76 01:23:09 INFO - PROCESS | 31078 | Values: 129.0 128.0 119.0 140.0 118.0 121.0 123.0 128.0 191.0 129.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.82 01:23:09 INFO - PROCESS | 31078 | Values: 163.0 165.0 167.0 161.0 166.0 160.0 160.0 167.0 164.0 164.0 01:23:09 INFO - PROCESS | 31078 | 01:23:09 INFO - PROCESS | 31078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.15 (1.8%) stddev-sans-first:0.97 01:23:09 INFO - PROCESS | 31078 | Values: 61.0 63.0 63.0 62.0 64.0 64.0 65.0 63.0 62.0 63.0 01:23:09 INFO - PROCESS | 31078 | -------- Summary: end -------- 01:23:09 INFO - PROCESS | 31078 | 01:23:10 INFO - TEST-INFO | 31078: exit 0 01:23:10 INFO - TEST-OK | kraken | took 62779ms 01:23:10 INFO - SUITE-END | took 1174s 01:23:10 INFO - Completed test suite (00:19:35) 01:23:10 INFO - javascript benchmark 01:23:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7195.591961175999, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.1414803854927, 3082.4143412751578, 3095.5975723155993, 3118.438681037414, 3121.8595163217637, 5208.374995000596, 5226.895462090761, 5289.973550132248, 5301.284326615906, 5318.840434786953, 5241.606879484035, 5334.386545547253, 5335.7865685372635, 5350.438203988583, 5426.2674538937235, 4830.734309612961, 4841.854744357657, 4949.628777841676, 4972.229304457815, 5018.34761481007, 748.6512424628255, 4848.272759086148, 5020.573251273646, 5046.54581087702, 5052.520010598987, 4865.245886887538, 4877.853664390074, 4878.02439512099, 4885.389326334208, 4902.779374928119, 4700.976495117537, 4862.343583616202, 4879.975600121977, 4898.8538923521755, 4937.777799998973, 4814.1334559779225, 4822.7829747661435, 4848.418189817209, 4858.344123543312, 4861.975690121562, 5256.342957130359, 5328.49379308965, 5364.597655175839, 5375.408705042481, 5420.91868621971, 5703.62926409782, 5739.081746920473, 5823.4467725566, 5823.5341172706085, 5824.504917082053, 5733.799317023926, 5773.971130144364, 5783.277090363705, 5791.507721843606, 5837.445442682938, 5374.973125134349, 5382.138857782736, 5383.865403364908, 5384.596155288369, 5396.379416367089, 5771.989901767174, 5810.157527158538, 5820.738066787005, 5844.26946631671, 5867.765289388462, 5600.159976003632, 5624.831255062355, 5634.464725851038, 5635.154726790932, 5636.802711905064, 5598.860028499239, 5712.685802280831, 5716.428357164334, 5721.656700597978, 5724.971375143181, 5603.551715862803, 5604.85987850307, 5615.578831587647, 5676.063449530781, 5679.233303503974, 5588.385277619459, 5697.430256974352, 5708.514776243983, 5758.798442054508, 5795.246617939641, 4195.811188496464, 4274.551172126882, 4301.397804307399, 4304.784760762012, 4360.454943132108, 3763.5483741950593, 3777.225668737902, 3805.1818858945458, 3813.656770890633, 3830.6743926766535, 5427.538659213932, 5433.510984011379, 5435.0, 5435.864103397446, 5438.83683489496, 5669.914951275734, 5683.204351390808, 5760.279965004374, 5760.942390576124, 5806.44838740319, 5388.137897936312, 5388.703621300788, 5393.056215162331, 5399.082156033483, 5418.4039755626845, 4771.785269662873, 4794.808207671724, 4796.544328288807, 4802.207635740064, 4821.180399332122, 5801.564882633735, 5811.3316968548315, 5878.5003274721275, 5890.0, 5892.351841297454, 5746.5977381583725, 5747.195392645117, 5747.74135163927, 5774.1338799178775, 5776.42235776419, 5874.735636896265, 5891.02798038336, 5900.350961394157, 5908.261467316585, 5935.732892019783, 5408.486193811582, 5700.429957004267, 5733.197352370755, 5754.050581654147, 5793.015187418233, 5809.419058094157, 5809.883802324014, 5810.302763668386, 5816.970915145397, 5844.707764611838, 5480.260164877691, 5684.630499017716, 5688.288963879515, 5693.146028095819, 5703.857403564944, 5491.835244942658, 5496.038193316073, 5513.558915286687, 5577.693226872561, 5582.8325150245555, 5356.303680521507, 5357.223202635674, 5427.701476418835, 5453.072977593898, 5498.092814685532, 5586.581006424616, 5598.300212473441, 5628.324601047737, 5641.323041235078, 5658.632188907708, 5386.380566234933, 5442.755076021668, 5453.318335208099, 5477.616566840442, 5529.0], "value": 5234.869420458273, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.1883956658512, 654.8919428294332, 657.2441692054138, 663.9336066393364, 674.1943377663691, 41630.79184604077, 42258.15483690328, 42287.577124228825, 42426.787866060666, 44351.0, 44160.558394416046, 44237.0, 44419.555804441945, 44534.10931781362, 44817.103657926906, 8663.39356245063, 8824.117588241157, 8826.73519794404, 8828.779280517974, 8841.38110332277, 8620.396572239946, 8672.60973256205, 8711.695090671828, 8723.345749068814, 8723.781905452352, 8756.518391488466, 8816.250618697419, 8816.823663526726, 8820.382573219877, 8823.382363234576, 8755.693550725726, 8758.649654013832, 8781.912180878237, 8783.34124940632, 8811.823763524693, 8711.695090671796, 8757.649694012232, 8788.472691638523, 8811.427257228259, 8823.073577274357, 41093.79453102745, 41273.1745365094, 41296.79351603253, 41511.584884151074, 41656.79171604153, 3440.415129428003, 3517.6306487818924, 3567.6967457766123, 3686.2811751708427, 3748.6438788315068, 30029.0, 30308.393832123456, 30480.390392192032, 32380.514292285636, 32578.0, 4243.575642435762, 4373.912521749579, 4493.168763778712, 4536.138133754576, 4540.72755634663, 344708.0, 344798.0, 345559.0, 345841.9999999975, 347238.0, 56545.0, 57686.0, 57713.71143144257, 59866.0, 60396.39603603996, 62819.0, 63356.36643633597, 63400.68299658472, 63455.36544634494, 63755.0, 16538.173091345383, 16579.585510362336, 16684.74972875408, 16748.330066797436, 16777.580560486087, 12239.204451710788, 12329.568465103857, 12353.814692779615, 12387.442565084593, 12430.316332601613, 18907.18570301609, 19142.521436964187, 19154.0, 19245.518862028282, 19287.589051368577, 7121.400688748673, 7335.303146201102, 7396.408287337, 7459.477836551498, 7489.812754681177, 1045.5556388534842, 1170.0931777872217, 1174.0666170394557, 1195.9043276537857, 1251.455616806692, 32313.51529727056, 32429.18927026796, 32549.34901302008, 32719.182020449203, 33197.17007074794, 1196.2642974570576, 1203.061611942686, 1242.3912282981455, 1259.1437822280755, 1269.676232560691, 17002.574935626708, 17110.0, 17179.656406871793, 17192.484225473258, 17214.1392930353, 557808.0, 565070.0, 566062.0, 566098.0, 566598.0, 57658.0, 59121.40878591159, 59368.406315936285, 59451.0, 59483.0, 1411.985880141206, 1413.4699487692114, 1421.393824977789, 1446.7106578684304, 1451.4702133721116, 30634.0, 32094.19764505906, 32264.418846492692, 32326.191845203117, 32336.0, 51423.48576514336, 51525.0, 51576.0, 51698.483015170874, 51956.74021629868, 459841.0, 462000.0, 462851.0, 463591.0, 464348.0, 25559.0, 25623.615645764956, 27795.722042779315, 27940.44119117647, 28028.0, 48719.51280487292, 48852.0, 49175.75412122916, 49662.25506617476, 49688.75155624199, 40305.0, 41431.0, 41792.582074180085, 41929.79035104805, 42159.578404215565, 39990.40014399844, 40546.1890762189, 40759.38860917148, 41502.1699566001, 41794.1641167181, 40925.38611920883, 41227.38158927559, 41367.0, 41415.0, 44241.115177695625, 34721.305573887876, 38159.23681526409, 38268.42597360986, 38400.423993640674, 38731.80634096924, 28745.712542874302, 28820.567691484226, 28988.42023159567, 28994.27514312159, 29195.41609167847], "value": 20427.671009592705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.8225239768303, 400.0798164222288, 401.24966312994707, 401.2977289742946, 419.2579134931172, 13649.590512284623, 17814.910925445372, 18343.08284585772, 19081.23675052998, 19171.329003484865, 16732.498025059267, 17019.40432084877, 17259.0, 17980.820191798077, 18108.275668973227, 5421.1326187809955, 5451.754671039793, 5595.7481913313795, 5635.6618602883955, 5659.801906933259, 5543.972280138593, 5548.889022219553, 5568.52667523261, 5581.3302403711405, 5590.385057643676, 5353.5984801139875, 5534.446555344473, 5538.47384498472, 5540.833774986757, 5592.217089607459, 5513.283273174462, 5544.500994910478, 5565.276514053167, 5582.469665381803, 5589.0219211637805, 4818.542238487338, 4974.651774375795, 4975.154223781966, 5001.9749901250625, 5007.048660754445, 21226.257081002244, 22194.556108877732, 22223.333300000864, 22279.220227292128, 22641.0, 2130.1585873579847, 2251.718535183102, 2268.2401395532515, 2355.211004313557, 2358.481134150484, 13687.726245475034, 14051.227182504957, 14106.85893141076, 14203.360848761831, 14249.50126745559, 1992.4919145617775, 2042.3056160905214, 2051.989740051305, 2053.897305134752, 2059.660156074246, 66512.3348766511, 71735.64132179305, 73284.0, 77830.22169778343, 77909.61045194737, 9830.655927042519, 10301.845472317922, 10495.953289108704, 10667.466626668636, 10683.732906677395, 14261.572152835432, 14276.0, 14331.140131592138, 14359.569212923629, 14360.348559915534, 7830.921690783133, 8193.590320483952, 8266.338692904554, 8300.667973281, 8395.286400656012, 8203.630836612367, 8216.0, 8274.29668478174, 8324.29243514296, 8451.281641060456, 6392.552521323462, 6460.580062295936, 6466.902996455057, 6550.312217217219, 6565.080888675589, 1876.2155359798714, 1924.5669724311917, 1926.402815127315, 1943.3392646500258, 1965.8132477414622, 938.4556956964944, 976.5215044628223, 980.6371642492181, 1020.5611587017654, 1045.29442626227, 17151.57121071983, 18376.724349134773, 18766.0, 19065.0, 19136.330228442217, 1037.4138611684375, 1039.594558122333, 1058.666520046183, 1063.0273299930632, 1097.2154909239932, 10529.262951593468, 10968.0, 10971.83542246867, 11079.612213572485, 11084.224104312621, 454314.0, 461155.0, 483587.0, 485778.0, 485917.0, 79693.0, 83693.58153209195, 83747.58126209452, 83790.0, 83962.0, 1034.5913364221242, 1056.4242487844144, 1056.4400867540062, 1070.7751372211767, 1078.7734575739182, 16807.831921681114, 16816.915915420344, 17016.48950531486, 17269.39557115495, 17346.21942012587, 36294.63705362913, 36993.0, 37376.43935340918, 38614.2277154461, 38985.41521877231, 50079.24881126859, 51121.7443912778, 51701.48298516967, 52572.474275256754, 52977.7351113242, 7947.0, 8120.593970301343, 8218.096009438837, 8223.629936652984, 8287.046989596274, 12100.515979360727, 12148.271103733805, 12260.877391225973, 12380.566680166152, 12400.441980110736, 10534.841977370192, 10912.945435272773, 11100.944495277472, 11115.166362522681, 11197.440127993405, 10729.731756706145, 10739.301945373525, 10845.24083314192, 10937.179711521827, 11062.723431913944, 10404.271700980858, 10519.474026298501, 10807.0, 10825.025747682746, 11098.112151027737, 7802.492837965514, 7885.842283154419, 7938.364930805406, 8026.8394632105865, 8084.7574572762915, 10715.089217416295, 11339.886601133883, 11486.310821350746, 11720.355380454157, 11745.0], "value": 9042.6019799845, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.8563736445037, 1519.0202319503917, 1716.2620073368455, 1800.1629242402296, 1824.0697244405358, 8110.9861267341585, 8696.21734043936, 8779.824403511933, 9422.811543769129, 9427.575759090849, 8778.297736181106, 9058.365914385995, 9078.682246121387, 9131.2238459731, 9147.496887671176, 2297.563462942044, 2320.628699408095, 2323.6398358254414, 2330.4406942333803, 2333.3583264602285, 2233.765454627265, 2245.315178870444, 2260.819134469247, 2275.5335156293004, 2276.237460450751, 2230.29745630126, 2275.4425165834396, 2284.0292875527916, 2323.8954247058923, 2340.941476463085, 2182.552576721776, 2222.822174226066, 2232.6316157833858, 2233.7542870284256, 2245.1692873636694, 2345.319857241398, 2347.0, 2367.112332875172, 2369.893354799038, 2376.607859703147, 9003.14470125337, 9022.097790220925, 9104.36269461138, 9105.499197544132, 9117.908820911773, 4980.676256043345, 5084.720340381277, 5124.538791508745, 5124.8206312778875, 5126.974365128188, 3134.6865313468697, 3179.2210908327606, 3352.8658853645825, 3366.461366181399, 3367.3938691035605, 1004.1364426593124, 1031.0, 1035.2753072848961, 1043.2540733375672, 1052.8736551613779, 12831.0, 12868.806967895489, 12878.034147438886, 12883.67790805228, 12976.87023129766, 4694.570686181932, 4791.305260737174, 4833.3958255218095, 4860.756962151878, 4865.148598995162, 10881.83677244842, 10899.891001090045, 10944.507497162647, 10946.0, 10950.561977520969, 5247.868803279948, 5279.683219006872, 5281.075811733008, 5281.788728450819, 5290.761915713802, 4254.957450425456, 4603.700759450625, 4628.490866004737, 4756.833510827105, 4759.4764575896625, 4124.773137477468, 4134.338505839051, 4137.179640957969, 4161.10536234711, 4161.271777438936, 1304.067591671959, 1304.9478020879249, 1312.0749871340681, 1317.7298653776145, 1328.7010422655019, 967.7000129959595, 1061.8035663402295, 1068.6740544134113, 1070.4487189097622, 1075.0593230922943, 6237.438630523275, 6462.32145624712, 6509.153810004764, 6510.121133646991, 6531.0, 430.8922769307673, 434.5372178629812, 439.9670024748157, 452.0552046223409, 452.66955122759913, 4336.588024137702, 4358.782060896942, 4373.934390984138, 4398.582134697199, 4429.557044295545, 11111.444427778579, 11482.655520334403, 11534.307941523535, 11562.07503399726, 11570.710732231762, 11343.773124537463, 11401.600943966921, 11417.771644567061, 11428.828567571492, 11430.657080287605, 8133.4306598538715, 8485.830283394298, 8504.617292221865, 8610.655573777103, 8611.483311001235, 6167.907481387693, 6324.747010119544, 6398.104265402941, 6501.674916254074, 6546.574472659262, 10335.534900929626, 10505.842412363667, 10595.152387808803, 10666.466676665981, 10725.0, 10495.212859035755, 10534.0, 10560.577576896838, 10717.249792514762, 10727.0, 7643.159252482334, 8368.916310837058, 8643.438176518506, 8735.91264087351, 8848.247898928663, 9002.684906028258, 9037.141471560191, 9043.457392556467, 9071.455712657262, 9091.59087841062, 7823.687052517836, 7940.920590794018, 8010.319122874621, 8051.1546287641295, 8169.264766170835, 7689.423293252917, 7689.923100769144, 7772.533647981139, 7830.373570114263, 7873.881891771513, 6920.134983127109, 7215.134183897966, 7285.453590980592, 7338.559686418832, 7349.191588925107, 5434.2935418395355, 5445.829146733471, 5511.889762204653, 5577.9442205577425, 5732.283464566929, 5488.9725551371985, 5492.5605951524585, 5530.695811730233, 5639.3232812062815, 5666.235058267246], "value": 4676.200837926332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.1935437210393, 331.89545293232635, 333.7380156577087, 336.78950655840083, 337.7838183562519, 5625.156226566017, 5641.18202860585, 5652.604317697757, 5665.461781130791, 5673.744681489333, 5556.16657501375, 5562.249096371998, 5586.217929489874, 5615.719214039292, 5639.492445679888, 4110.917781644365, 4194.286971214886, 4340.327249276367, 4343.739375637456, 4344.391785150082, 4306.483222013363, 4325.026868954492, 4334.501532323791, 4349.434573505456, 4393.956060439386, 4281.571842815709, 4302.677299202556, 4304.5910638489295, 4316.892077698051, 4331.548931108083, 4148.91702165958, 4284.485861696585, 4307.784610769449, 4320.978395108004, 4342.652587792984, 3755.9483344663263, 3767.2277183177384, 3771.5662698789715, 3785.6592906638534, 3788.29916465452, 5333.146696528575, 5433.0, 5441.2654291670515, 5447.945520544784, 5458.699771512565, 4774.7135171889795, 4880.243562247857, 4901.240307752304, 4915.115279249733, 4991.650584459089, 5759.913601295942, 5769.451902069339, 5798.681072541009, 5811.564132690065, 5842.561807864385, 4130.070734084837, 4139.937900931458, 4153.673942592158, 4154.5222299435345, 4160.54234034256, 5884.823455296348, 6076.118962750376, 6169.383061693839, 6187.504999600066, 6211.906821397728, 4185.309423945076, 4194.573844892751, 4229.767362795014, 4233.280342341748, 4259.574042595716, 4230.280852255124, 4247.00195454068, 4275.957240427556, 4288.421063156434, 4295.742255464682, 4754.738489383048, 4885.877853053631, 4905.435874874363, 4910.48439913811, 4968.757810547363, 5850.297964244318, 5872.706364681749, 5883.382244864228, 5889.499392551681, 5929.762809487572, 1467.1710483576744, 1488.977665335021, 1493.2981498695597, 1496.2593516209329, 1500.5423345879612, 939.2532936315646, 953.50894289441, 970.0687340153531, 989.6288891665625, 1002.2132625888788, 5524.861878453071, 5585.888282234414, 5599.496045355856, 5603.103503439512, 5612.410696876851, 5967.283925928917, 5998.670073145931, 6001.759929602855, 6015.646479542155, 6063.363346848518, 5501.119820828648, 5516.365617953907, 5621.718914054362, 5634.7182640867795, 5637.605367624227, 3192.0, 3219.6780321967617, 3264.9347013059605, 3290.3254832759226, 3302.3230237801195, 5888.381719919433, 6241.21984751906, 6248.843778905563, 6261.436470717657, 6318.684065796691, 6031.909521357183, 6082.726277317532, 6102.511799056065, 6142.938570614326, 6174.722137503823, 6230.190075290274, 6253.5622506425025, 6272.780452684134, 6299.149614802126, 6333.050042493571, 5829.795957141479, 5943.989521781394, 6057.0, 6070.484008859296, 6076.116403914801, 5930.458080899084, 5964.419428851271, 5967.164596956516, 5972.193753843176, 5972.522198224218, 6018.578699490994, 6242.28213755424, 6248.625082495065, 6267.088537995955, 6285.214348206474, 4239.59723826236, 4258.659307255474, 4258.808353624157, 4265.21093597673, 4267.445232119929, 5981.401859813984, 6005.969970150121, 6025.216721826135, 6045.576809623284, 6058.7273572688455, 5645.830625081254, 5815.2149459822385, 5836.212111364912, 5844.15259787337, 5844.415558444121, 5766.250387449605, 5776.277965254343, 5828.125781132864, 5883.264591926009, 5892.616979896293, 5169.61227907916, 5698.743556539883, 5711.171880077449, 5723.771049157987, 5739.770409183586, 5799.710014499343, 5858.326292476249, 5883.646981181143, 5885.792827689616, 5935.525157987437, 5733.369329373849, 5776.42235776419, 5783.248177736868, 5846.678432686073, 5869.236999190078], "value": 4445.841003682202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.5723994563042, 800.2917418084995, 815.0438946528335, 824.9010118785744, 828.6022709099632, 14086.295685215737, 15045.774313385295, 15075.246237688127, 15118.092914425142, 15223.695526089485, 13834.100783449068, 13868.653283667913, 13870.0, 13893.513727019556, 13935.37290821913, 673.9561928474634, 796.2157275084038, 807.1645846548838, 818.5088946632033, 821.9589020548949, 814.914433984429, 818.3657665309403, 819.0908092017855, 819.1685439279107, 819.2381085590398, 860.084010528788, 864.5979619476973, 865.6061492021115, 866.644675682967, 867.657275376226, 850.783050322167, 851.535912927456, 851.6848765956605, 852.1606217875387, 852.9744107676779, 626.1265534579281, 628.5317438508295, 628.6510986402545, 629.1663545801786, 629.9401556852092, 14056.85943140576, 14141.929290353586, 14160.575182744535, 14161.504347347896, 14168.220747858864, 13991.58025259244, 14030.228337441436, 14061.367238474191, 14227.21750303733, 14259.358328875225, 11394.0, 11587.652370428901, 11694.883051169465, 11706.707332316675, 11776.11679124069, 3858.6141385861188, 3881.7670939743425, 3952.822123004472, 3977.085270387827, 4036.4752582164133, 55060.0, 55102.44897551013, 55206.17190742142, 55597.0, 55991.72004139994, 10978.945105274583, 11004.889951100547, 11101.83347249792, 11138.108951283877, 11398.94300528492, 20051.598968020557, 20098.39704808858, 20159.798402015793, 20206.0, 20299.898500507697, 8197.631106600218, 8205.548694821842, 8273.924389829404, 8537.146285371413, 8553.743387698254, 4602.976985115053, 4607.124646317189, 4624.329472226508, 4627.8843028923875, 4824.782884770194, 3182.7612929030415, 3268.3299923515624, 3271.8200498972783, 3273.2307907641684, 3277.524758909945, 600.2017316968421, 612.6967151260154, 616.9321374648785, 617.2161355079024, 629.3926361061598, 648.0441349010172, 658.9439897608661, 727.1492353945896, 750.5271678842404, 755.7354925775934, 9222.354435189472, 9658.661946831828, 9659.661911833053, 9787.804243915081, 9814.558344874498, 741.9698358057364, 768.4582369429651, 770.9074911010715, 785.7996210966166, 801.6552882260684, 4212.304969679968, 4303.761082779464, 4406.82533899618, 4486.170058539181, 4533.909321813545, 58116.0, 72790.63604681943, 72822.63588682022, 72966.0, 73272.63363683148, 53682.7315863426, 56711.0, 57164.14253786197, 57978.420215797305, 59546.0, 54387.0, 54568.727156363966, 54990.725046374515, 55448.44551554433, 56055.0, 9538.475383853676, 9657.46883921391, 9673.758156046155, 9700.660476883275, 9765.072318129767, 35374.46938295979, 35799.46300805438, 36104.63895361118, 36364.45453318255, 36505.976513875976, 46714.0, 48158.759206203744, 48626.0, 48669.2699609499, 48855.75572122259, 11505.712357191138, 12288.877111228774, 12308.630741077783, 12689.492420303084, 12927.224366538037, 13273.203607783564, 13332.143494556765, 13767.173969561858, 14045.08706934046, 14600.926995364955, 12962.675933101747, 13104.344782761014, 13157.60527184186, 13231.536896208587, 13748.65628359299, 12070.0, 12103.757924841279, 12141.332226727614, 12377.443015064164, 12397.318147501974, 12587.93706031464, 12615.621531354074, 12919.289439080942, 13065.0, 13556.186628802303, 10453.320534165256, 10568.0, 10715.732106697395, 10951.945240273748, 11001.724956876142, 10813.134949204203, 11044.116470682487, 11188.384638844942, 11243.381614011309, 11261.380624065427], "value": 6903.834827192957, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 110.0, 111.0, 110.0, 113.0, 110.0, 111.0, 115.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 154.0, 206.0, 126.0, 149.0, 154.0, 127.0, 175.0, 127.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 165.0, 176.0, 163.0, 173.0, 162.0, 161.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 166.0, 75.0, 75.0, 76.0, 73.0, 176.0, 74.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 172.0, 93.0, 94.0, 93.0, 144.0, 93.0, 93.0, 138.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 148.0, 145.0], "value": 146.5, "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, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 56.0, 56.0, 60.0, 57.0, 58.0, 106.0, 55.0, 59.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 75.0, 62.0, 63.0, 62.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 79.0, 79.0, 80.0, 79.0, 78.0, 81.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 119.0, 140.0, 118.0, 121.0, 123.0, 128.0, 191.0, 129.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 167.0, 161.0, 166.0, 160.0, 160.0, 167.0, 164.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 62.0, 64.0, 64.0, 65.0, 63.0, 62.0, 63.0], "value": 63.0, "unit": "score"}]}]} 01:23:10 INFO - Return code: 0 01:23:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:23:10 ERROR - # TBPL SUCCESS # 01:23:10 INFO - Running post-action listener: _resource_record_post_action 01:23:10 INFO - ##### 01:23:10 INFO - ##### Finished run-tests step (success) 01:23:10 INFO - ##### 01:23:10 INFO - Running post-run listener: _resource_record_post_run 01:23:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306139136; Read time: 12; Write time: 231792 01:23:10 INFO - TinderboxPrint: CPU usage
13.3% 01:23:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:23:10 INFO - TinderboxPrint: I/O write bytes / time
306,139,136 / 231,792 01:23:10 INFO - TinderboxPrint: CPU idle
8,247.9 (86.6%) 01:23:10 INFO - TinderboxPrint: CPU user
1,219.4 (12.8%) 01:23:10 INFO - TinderboxPrint: Swap in / out
0 / 0 01:23:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20074496; Read time: 0; Write time: 22352 01:23:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283549696; Read time: 12; Write time: 207972 01:23:11 INFO - Running post-run listener: _upload_blobber_files 01:23:11 INFO - Blob upload gear active. 01:23:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:23:11 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 01:23:11 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'] 01:23:11 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 01:23:11 INFO - (blobuploader) - INFO - Open directory for files ... 01:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:12 INFO - (blobuploader) - INFO - Done attempting. 01:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:13 INFO - (blobuploader) - INFO - Done attempting. 01:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:23:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:16 INFO - (blobuploader) - INFO - Done attempting. 01:23:16 INFO - (blobuploader) - INFO - Iteration through files over. 01:23:16 INFO - Return code: 0 01:23:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:23:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:23:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/777982e1f563ac2ad76cd62882c4d6462c14cb4199b3a2a6a5f26556771d43e4e338050fb807d2ce3bbb4cd38eae5feac29da704fa7d2e28f9263b28bb9278e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e24fd5aba216ab274937fa04a30181c8eef0f10279114c865076c4e3b44b40eb23b8877f249d190c825a0195a889abc2c31ac80bca79b3f51282cb9afb58c9b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c76dcecff04e0a37484a1fb6a98c1d3fcc85d6f2e32f148a86a1eb521a71a1ec639a4caecd395b69e7c5545587d4768b0791d2ca0fc8ca8d3357bdf7e4ca1db"} 01:23:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:23:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:23:16 INFO - Contents: 01:23:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/777982e1f563ac2ad76cd62882c4d6462c14cb4199b3a2a6a5f26556771d43e4e338050fb807d2ce3bbb4cd38eae5feac29da704fa7d2e28f9263b28bb9278e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e24fd5aba216ab274937fa04a30181c8eef0f10279114c865076c4e3b44b40eb23b8877f249d190c825a0195a889abc2c31ac80bca79b3f51282cb9afb58c9b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c76dcecff04e0a37484a1fb6a98c1d3fcc85d6f2e32f148a86a1eb521a71a1ec639a4caecd395b69e7c5545587d4768b0791d2ca0fc8ca8d3357bdf7e4ca1db"} 01:23:16 INFO - Running post-run listener: copy_logs_to_upload_dir 01:23:16 INFO - Copying logs to upload dir... 01:23:16 INFO - mkdir: /builds/slave/test/build/upload/logs 01:23:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.121313 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-05-21 01:23:16.771896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:23:16.776038) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/777982e1f563ac2ad76cd62882c4d6462c14cb4199b3a2a6a5f26556771d43e4e338050fb807d2ce3bbb4cd38eae5feac29da704fa7d2e28f9263b28bb9278e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e24fd5aba216ab274937fa04a30181c8eef0f10279114c865076c4e3b44b40eb23b8877f249d190c825a0195a889abc2c31ac80bca79b3f51282cb9afb58c9b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c76dcecff04e0a37484a1fb6a98c1d3fcc85d6f2e32f148a86a1eb521a71a1ec639a4caecd395b69e7c5545587d4768b0791d2ca0fc8ca8d3357bdf7e4ca1db"} build_url:https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/cNdcFojLT2WgPhr7qALQ6g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/777982e1f563ac2ad76cd62882c4d6462c14cb4199b3a2a6a5f26556771d43e4e338050fb807d2ce3bbb4cd38eae5feac29da704fa7d2e28f9263b28bb9278e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e24fd5aba216ab274937fa04a30181c8eef0f10279114c865076c4e3b44b40eb23b8877f249d190c825a0195a889abc2c31ac80bca79b3f51282cb9afb58c9b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c76dcecff04e0a37484a1fb6a98c1d3fcc85d6f2e32f148a86a1eb521a71a1ec639a4caecd395b69e7c5545587d4768b0791d2ca0fc8ca8d3357bdf7e4ca1db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:23:16.802378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:23:16.802972) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1463816896.278850-2050191336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:23:16.890663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:23:16.891054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:23:16.891416) ========= ========= Total master_lag: 0.18 =========