builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1464743672.87 results: success (0) buildid: 20160531170040 builduid: 256b4d1e46294317b2ecd148e807de92 revision: 25321494921c824703a605127fb1f99b1faf5910 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:32.873055) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:32.873707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:32.873998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:32.899191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:32.899792) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 18:14:32-- 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% 46.8M=0s 2016-05-31 18:14:33 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122126 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.048060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.048339) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018529 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.103545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.103972) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25321494921c824703a605127fb1f99b1faf5910 --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 25321494921c824703a605127fb1f99b1faf5910 --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=c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 18:14:33,218 truncating revision to first 12 chars 2016-05-31 18:14:33,218 Setting DEBUG logging. 2016-05-31 18:14:33,218 attempt 1/10 2016-05-31 18:14:33,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25321494921c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 18:14:33,522 unpacking tar archive at: mozilla-central-25321494921c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.837305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.837650) ========= script_repo_revision: 25321494921c824703a605127fb1f99b1faf5910 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.838058) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.838331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 18:14:33.848815) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-31 18:14:33.849091) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:14:34 INFO - MultiFileLogger online at 20160531 18:14:34 in /builds/slave/test 18:14:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:14:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:14:34 INFO - {'append_to_log': False, 18:14:34 INFO - 'base_work_dir': '/builds/slave/test', 18:14:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:14:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:14:34 INFO - 'branch': 'Firefox-Non-PGO', 18:14:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:14:34 INFO - 'config_files': ('talos/linux_config.py',), 18:14:34 INFO - 'default_actions': ('clobber', 18:14:34 INFO - 'read-buildbot-config', 18:14:34 INFO - 'download-and-extract', 18:14:34 INFO - 'populate-webroot', 18:14:34 INFO - 'create-virtualenv', 18:14:34 INFO - 'install', 18:14:34 INFO - 'run-tests'), 18:14:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:14:34 INFO - 'download_minidump_stackwalk': True, 18:14:34 INFO - 'download_symbols': 'ondemand', 18:14:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:14:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:14:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:14:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:14:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:14:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:14:34 INFO - 'installer_path': 'installer.exe', 18:14:34 INFO - 'log_level': 'info', 18:14:34 INFO - 'log_name': 'talos', 18:14:34 INFO - 'log_to_console': True, 18:14:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:14:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:14:34 INFO - 'opt_config_files': (), 18:14:34 INFO - 'pip_index': False, 18:14:34 INFO - 'sps_profile': False, 18:14:34 INFO - 'sps_profile_interval': 0, 18:14:34 INFO - 'suite': 'dromaeojs-e10s', 18:14:34 INFO - 'system_bits': '32', 18:14:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:14:34 INFO - 'title': 'talos-linux64-ix-004', 18:14:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:14:34 INFO - 'use_talos_json': True, 18:14:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:14:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:14:34 INFO - 'work_dir': 'build'} 18:14:34 INFO - ##### 18:14:34 INFO - ##### Running clobber step. 18:14:34 INFO - ##### 18:14:34 INFO - Running pre-action listener: _resource_record_pre_action 18:14:34 INFO - Running main action method: clobber 18:14:34 INFO - rmtree: /builds/slave/test/build 18:14:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:14:35 INFO - Running post-action listener: _resource_record_post_action 18:14:35 INFO - ##### 18:14:35 INFO - ##### Finished clobber step (success) 18:14:35 INFO - ##### 18:14:35 INFO - ##### 18:14:35 INFO - ##### Running read-buildbot-config step. 18:14:35 INFO - ##### 18:14:35 INFO - Running pre-action listener: _resource_record_pre_action 18:14:35 INFO - Running main action method: read_buildbot_config 18:14:35 INFO - Using buildbot properties: 18:14:35 INFO - { 18:14:35 INFO - "project": "", 18:14:35 INFO - "product": "firefox", 18:14:35 INFO - "script_repo_revision": "production", 18:14:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:14:35 INFO - "repository": "", 18:14:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:14:35 INFO - "buildid": "20160531170040", 18:14:35 INFO - "pgo_build": "False", 18:14:35 INFO - "basedir": "/builds/slave/test", 18:14:35 INFO - "buildnumber": 73, 18:14:35 INFO - "slavename": "talos-linux64-ix-004", 18:14:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:14:35 INFO - "platform": "ubuntu64_hw", 18:14:35 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:14:35 INFO - "branch": "mozilla-central", 18:14:35 INFO - "repo_path": "mozilla-central", 18:14:35 INFO - "revision": "25321494921c824703a605127fb1f99b1faf5910", 18:14:35 INFO - "stage_platform": "linux64", 18:14:35 INFO - "builduid": "256b4d1e46294317b2ecd148e807de92", 18:14:35 INFO - "slavebuilddir": "test" 18:14:35 INFO - } 18:14:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:14:35 INFO - Running post-action listener: _resource_record_post_action 18:14:35 INFO - ##### 18:14:35 INFO - ##### Finished read-buildbot-config step (success) 18:14:35 INFO - ##### 18:14:35 INFO - ##### 18:14:35 INFO - ##### Running download-and-extract step. 18:14:35 INFO - ##### 18:14:35 INFO - Running pre-action listener: _resource_record_pre_action 18:14:35 INFO - Running main action method: download_and_extract 18:14:35 INFO - mkdir: /builds/slave/test/build/tests 18:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:35 INFO - https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:35 INFO - Downloaded 1361 bytes. 18:14:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:14:35 INFO - Using the following test package requirements: 18:14:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:14:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:14:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:14:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'jsshell-linux-x86_64.zip'], 18:14:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:14:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:14:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:14:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:14:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:14:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:14:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:14:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:35 INFO - https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:36 INFO - Downloaded 22840484 bytes. 18:14:36 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'] 18:14:36 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 18:14:38 INFO - Return code: 0 18:14:38 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 18:14: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')]} 18:14:38 INFO - https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:43 INFO - Downloaded 22840484 bytes. 18:14:43 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'] 18:14:43 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 18:14:44 INFO - Return code: 0 18:14:44 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')]} 18:14:44 INFO - https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:47 INFO - Downloaded 10834055 bytes. 18:14:47 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'] 18:14:47 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 18:14:47 INFO - Return code: 0 18:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:47 INFO - https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:14:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:14:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:14:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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 18:14:48 INFO - Downloaded 55032110 bytes. 18:14:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:14:48 INFO - mkdir: /builds/slave/test/properties 18:14:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:14:48 INFO - Writing to file /builds/slave/test/properties/build_url 18:14:48 INFO - Contents: 18:14:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:14:49 INFO - Running post-action listener: _resource_record_post_action 18:14:49 INFO - Running post-action listener: set_extra_try_arguments 18:14:49 INFO - ##### 18:14:49 INFO - ##### Finished download-and-extract step (success) 18:14:49 INFO - ##### 18:14:49 INFO - ##### 18:14:49 INFO - ##### Running populate-webroot step. 18:14:49 INFO - ##### 18:14:49 INFO - Running pre-action listener: _resource_record_pre_action 18:14:49 INFO - Running main action method: populate_webroot 18:14:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:14:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:14:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:14:49 INFO - '--tppagecycles', 18:14:49 INFO - '7'], 18:14:49 INFO - 'tests': ['tsvgm']}}, 18:14:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:14:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:14:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:14:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:14:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['damp', 'tps']}, 18:14:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'tests': ['damp', 'tps']}, 18:14:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['dromaeo_dom']}, 18:14:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:14:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['a11yr', 18:14:49 INFO - 'ts_paint', 18:14:49 INFO - 'tpaint', 18:14:49 INFO - 'sessionrestore', 18:14:49 INFO - 'sessionrestore_no_auto_restore', 18:14:49 INFO - 'tabpaint']}, 18:14:49 INFO - 'other-e10s': {'tests': ['a11yr', 18:14:49 INFO - 'ts_paint', 18:14:49 INFO - 'tpaint', 18:14:49 INFO - 'sessionrestore', 18:14:49 INFO - 'sessionrestore_no_auto_restore', 18:14:49 INFO - 'tabpaint']}, 18:14:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:14:49 INFO - 'ts_paint', 18:14:49 INFO - 'tpaint', 18:14:49 INFO - 'sessionrestore', 18:14:49 INFO - 'sessionrestore_no_auto_restore', 18:14:49 INFO - 'tabpaint']}, 18:14:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:14:49 INFO - 'ts_paint', 18:14:49 INFO - 'tpaint', 18:14:49 INFO - 'sessionrestore', 18:14:49 INFO - 'sessionrestore_no_auto_restore', 18:14:49 INFO - 'tabpaint']}, 18:14:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['a11yr', 18:14:49 INFO - 'ts_paint', 18:14:49 INFO - 'tpaint', 18:14:49 INFO - 'sessionrestore', 18:14:49 INFO - 'sessionrestore_no_auto_restore', 18:14:49 INFO - 'tabpaint']}, 18:14:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['a11yr', 18:14:49 INFO - 'ts_paint', 18:14:49 INFO - 'tpaint', 18:14:49 INFO - 'sessionrestore', 18:14:49 INFO - 'sessionrestore_no_auto_restore', 18:14:49 INFO - 'tabpaint']}, 18:14:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['tsvgx', 18:14:49 INFO - 'tsvgr_opacity', 18:14:49 INFO - 'tart', 18:14:49 INFO - 'tscrollx', 18:14:49 INFO - 'cart']}, 18:14:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:14:49 INFO - 'tsvgr_opacity', 18:14:49 INFO - 'tart', 18:14:49 INFO - 'tscrollx', 18:14:49 INFO - 'cart']}, 18:14:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'talos_options': ['--disable-e10s'], 18:14:49 INFO - 'tests': ['tp5o']}, 18:14:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'tests': ['tp5o']}, 18:14:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'talos_options': ['--disable-e10s', 18:14:49 INFO - '--xperf_path', 18:14:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:49 INFO - 'tests': ['tp5n']}, 18:14:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:14:49 INFO - 'talos_options': ['--xperf_path', 18:14:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:49 INFO - 'tests': ['tp5n']}}, 18:14:49 INFO - 'talos.zip': {'path': '', 18:14:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:14:49 INFO - Running post-action listener: _resource_record_post_action 18:14:49 INFO - ##### 18:14:49 INFO - ##### Finished populate-webroot step (success) 18:14:49 INFO - ##### 18:14:49 INFO - ##### 18:14:49 INFO - ##### Running create-virtualenv step. 18:14:49 INFO - ##### 18:14:49 INFO - Running pre-action listener: _resource_record_pre_action 18:14:49 INFO - Running main action method: create_virtualenv 18:14:49 INFO - Creating virtualenv /builds/slave/test/build/venv 18:14:49 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 18:14:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:14:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:14:50 INFO - Using real prefix '/usr' 18:14:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:14:50 INFO - Installing distribute.............................................................................................................................................................................................done. 18:14:52 INFO - Installing pip.................done. 18:14:52 INFO - Return code: 0 18:14:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:14:52 INFO - Using env: {'DISPLAY': ':0', 18:14:52 INFO - 'HOME': '/home/cltbld', 18:14:52 INFO - 'LANG': 'en_US.UTF-8', 18:14:52 INFO - 'LANGUAGE': 'en_US:en', 18:14:52 INFO - 'LOGNAME': 'cltbld', 18:14:52 INFO - 'MAIL': '/var/mail/cltbld', 18:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:52 INFO - 'MOZ_NO_REMOTE': '1', 18:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:52 INFO - 'NO_EM_RESTART': '1', 18:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:52 INFO - 'PWD': '/builds/slave/test', 18:14:52 INFO - 'SHELL': '/bin/bash', 18:14:52 INFO - 'SHLVL': '1', 18:14:52 INFO - 'TERM': 'linux', 18:14:52 INFO - 'TMOUT': '86400', 18:14:52 INFO - 'USER': 'cltbld', 18:14:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:52 INFO - '_': '/tools/buildbot/bin/python'} 18:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:52 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 18:14:52 INFO - Cleaning up... 18:14:52 INFO - Return code: 0 18:14:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:14:52 INFO - Using env: {'DISPLAY': ':0', 18:14:52 INFO - 'HOME': '/home/cltbld', 18:14:52 INFO - 'LANG': 'en_US.UTF-8', 18:14:52 INFO - 'LANGUAGE': 'en_US:en', 18:14:52 INFO - 'LOGNAME': 'cltbld', 18:14:52 INFO - 'MAIL': '/var/mail/cltbld', 18:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:52 INFO - 'MOZ_NO_REMOTE': '1', 18:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:52 INFO - 'NO_EM_RESTART': '1', 18:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:52 INFO - 'PWD': '/builds/slave/test', 18:14:52 INFO - 'SHELL': '/bin/bash', 18:14:52 INFO - 'SHLVL': '1', 18:14:52 INFO - 'TERM': 'linux', 18:14:52 INFO - 'TMOUT': '86400', 18:14:52 INFO - 'USER': 'cltbld', 18:14:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:52 INFO - '_': '/tools/buildbot/bin/python'} 18:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:52 INFO - Downloading/unpacking psutil>=3.1.1 18:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:14:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:54 INFO - Installing collected packages: psutil 18:14:54 INFO - Running setup.py install for psutil 18:14:55 INFO - building 'psutil._psutil_linux' extension 18:14:55 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 18:14:55 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 18:14:55 INFO - building 'psutil._psutil_posix' extension 18:14:55 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 18:14:55 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 18:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:55 INFO - Successfully installed psutil 18:14:55 INFO - Cleaning up... 18:14:55 INFO - Return code: 0 18:14:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:14: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:14: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 mozsystemmonitor==0.3 18:14:55 INFO - Using env: {'DISPLAY': ':0', 18:14:55 INFO - 'HOME': '/home/cltbld', 18:14:55 INFO - 'LANG': 'en_US.UTF-8', 18:14:55 INFO - 'LANGUAGE': 'en_US:en', 18:14:55 INFO - 'LOGNAME': 'cltbld', 18:14:55 INFO - 'MAIL': '/var/mail/cltbld', 18:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:55 INFO - 'MOZ_NO_REMOTE': '1', 18:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:55 INFO - 'NO_EM_RESTART': '1', 18:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:55 INFO - 'PWD': '/builds/slave/test', 18:14:55 INFO - 'SHELL': '/bin/bash', 18:14:55 INFO - 'SHLVL': '1', 18:14:55 INFO - 'TERM': 'linux', 18:14:55 INFO - 'TMOUT': '86400', 18:14:55 INFO - 'USER': 'cltbld', 18:14:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:55 INFO - '_': '/tools/buildbot/bin/python'} 18:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:14:57 INFO - Installing collected packages: mozsystemmonitor 18:14:57 INFO - Running setup.py install for mozsystemmonitor 18:14:57 INFO - Successfully installed mozsystemmonitor 18:14:57 INFO - Cleaning up... 18:14:57 INFO - Return code: 0 18:14:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:57 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 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:14:57 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 18:14:57 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 18:14:57 INFO - Using env: {'DISPLAY': ':0', 18:14:57 INFO - 'HOME': '/home/cltbld', 18:14:57 INFO - 'LANG': 'en_US.UTF-8', 18:14:57 INFO - 'LANGUAGE': 'en_US:en', 18:14:57 INFO - 'LOGNAME': 'cltbld', 18:14:57 INFO - 'MAIL': '/var/mail/cltbld', 18:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:57 INFO - 'MOZ_NO_REMOTE': '1', 18:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:57 INFO - 'NO_EM_RESTART': '1', 18:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:57 INFO - 'PWD': '/builds/slave/test', 18:14:57 INFO - 'SHELL': '/bin/bash', 18:14:57 INFO - 'SHLVL': '1', 18:14:57 INFO - 'TERM': 'linux', 18:14:57 INFO - 'TMOUT': '86400', 18:14:57 INFO - 'USER': 'cltbld', 18:14:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:57 INFO - '_': '/tools/buildbot/bin/python'} 18:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14: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 18:14:59 INFO - Downloading blobuploader-1.2.4.tar.gz 18:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:14:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:14:59 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 18:14:59 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 18:14:59 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 18:14:59 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 18:14:59 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 18:14:59 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 18:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:15:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15:00 INFO - Downloading docopt-0.6.1.tar.gz 18:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:15:00 INFO - Installing collected packages: blobuploader, requests, docopt 18:15:00 INFO - Running setup.py install for blobuploader 18:15:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:15:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:15:00 INFO - Running setup.py install for requests 18:15:01 INFO - Running setup.py install for docopt 18:15:01 INFO - Successfully installed blobuploader requests docopt 18:15:01 INFO - Cleaning up... 18:15:01 INFO - Return code: 0 18:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:01 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 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:15:01 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 18:15:01 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 18:15:01 INFO - Using env: {'DISPLAY': ':0', 18:15:01 INFO - 'HOME': '/home/cltbld', 18:15:01 INFO - 'LANG': 'en_US.UTF-8', 18:15:01 INFO - 'LANGUAGE': 'en_US:en', 18:15:01 INFO - 'LOGNAME': 'cltbld', 18:15:01 INFO - 'MAIL': '/var/mail/cltbld', 18:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:01 INFO - 'MOZ_NO_REMOTE': '1', 18:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:01 INFO - 'NO_EM_RESTART': '1', 18:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:01 INFO - 'PWD': '/builds/slave/test', 18:15:01 INFO - 'SHELL': '/bin/bash', 18:15:01 INFO - 'SHLVL': '1', 18:15:01 INFO - 'TERM': 'linux', 18:15:01 INFO - 'TMOUT': '86400', 18:15:01 INFO - 'USER': 'cltbld', 18:15:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:01 INFO - '_': '/tools/buildbot/bin/python'} 18:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:15:01 INFO - Running setup.py (path:/tmp/pip-lTsIi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:15:01 INFO - Running setup.py (path:/tmp/pip-PPH1JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:15:01 INFO - Running setup.py (path:/tmp/pip-43AgYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:15:01 INFO - Running setup.py (path:/tmp/pip-nrNCTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:15:01 INFO - Running setup.py (path:/tmp/pip-kmYXtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:15:01 INFO - Running setup.py (path:/tmp/pip-BptVkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:15:01 INFO - Running setup.py (path:/tmp/pip-TJWPah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:15:01 INFO - Running setup.py (path:/tmp/pip-U4L2yY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:15:02 INFO - Running setup.py (path:/tmp/pip-ebHywC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:15:02 INFO - Running setup.py (path:/tmp/pip-3ly5eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:15:02 INFO - Running setup.py (path:/tmp/pip-ntT2gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:15:02 INFO - Running setup.py (path:/tmp/pip-KLSkE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:15:02 INFO - Running setup.py (path:/tmp/pip-EaMf17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:15:02 INFO - Running setup.py (path:/tmp/pip-zNOV3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:02 INFO - Running setup.py (path:/tmp/pip-ozbm4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:15:02 INFO - Running setup.py (path:/tmp/pip-KG93bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:15:02 INFO - Running setup.py (path:/tmp/pip-53dLi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:15:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:15:02 INFO - Running setup.py install for manifestparser 18:15:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:15:02 INFO - Running setup.py install for mozcrash 18:15:02 INFO - Running setup.py install for mozdebug 18:15:02 INFO - Running setup.py install for mozdevice 18:15:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Running setup.py install for mozfile 18:15:03 INFO - Running setup.py install for mozhttpd 18:15:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Running setup.py install for mozinfo 18:15:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Running setup.py install for mozInstall 18:15:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Running setup.py install for mozleak 18:15:03 INFO - Running setup.py install for mozlog 18:15:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Running setup.py install for moznetwork 18:15:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:15:03 INFO - Running setup.py install for mozprocess 18:15:03 INFO - Running setup.py install for mozprofile 18:15:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:15:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:15:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:15:04 INFO - Running setup.py install for mozrunner 18:15:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:15:04 INFO - Running setup.py install for mozscreenshot 18:15:04 INFO - Running setup.py install for moztest 18:15:04 INFO - Running setup.py install for mozversion 18:15:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:15:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:15:04 INFO - Cleaning up... 18:15:04 INFO - Return code: 0 18:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:15: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')]} 18:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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')]} 18:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:04 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 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:15:04 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 18:15:04 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 18:15:04 INFO - Using env: {'DISPLAY': ':0', 18:15:04 INFO - 'HOME': '/home/cltbld', 18:15:04 INFO - 'LANG': 'en_US.UTF-8', 18:15:04 INFO - 'LANGUAGE': 'en_US:en', 18:15:04 INFO - 'LOGNAME': 'cltbld', 18:15:04 INFO - 'MAIL': '/var/mail/cltbld', 18:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:04 INFO - 'MOZ_NO_REMOTE': '1', 18:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:04 INFO - 'NO_EM_RESTART': '1', 18:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:04 INFO - 'PWD': '/builds/slave/test', 18:15:04 INFO - 'SHELL': '/bin/bash', 18:15:04 INFO - 'SHLVL': '1', 18:15:04 INFO - 'TERM': 'linux', 18:15:04 INFO - 'TMOUT': '86400', 18:15:04 INFO - 'USER': 'cltbld', 18:15:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:04 INFO - '_': '/tools/buildbot/bin/python'} 18:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:15:04 INFO - Running setup.py (path:/tmp/pip-B9azFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:15:04 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)) 18:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:15:04 INFO - Running setup.py (path:/tmp/pip-39KtiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:15:04 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)) 18:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:15:04 INFO - Running setup.py (path:/tmp/pip-V8WctQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:15:04 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)) 18:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:15:04 INFO - Running setup.py (path:/tmp/pip-eurQBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:15:04 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)) 18:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:15:04 INFO - Running setup.py (path:/tmp/pip-9lciP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:15:05 INFO - Running setup.py (path:/tmp/pip-mncmW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:15:05 INFO - Running setup.py (path:/tmp/pip-1HVoBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:15:05 INFO - Running setup.py (path:/tmp/pip-CVWszj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:15:05 INFO - Running setup.py (path:/tmp/pip-rT57ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:15:05 INFO - Running setup.py (path:/tmp/pip-EXpcBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:15:05 INFO - Running setup.py (path:/tmp/pip-GFzWUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:15:05 INFO - Running setup.py (path:/tmp/pip-EK20mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:15:05 INFO - Running setup.py (path:/tmp/pip-AlFot6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:15:05 INFO - Running setup.py (path:/tmp/pip-iPHwvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:05 INFO - Running setup.py (path:/tmp/pip-2rlV4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:15:05 INFO - Running setup.py (path:/tmp/pip-ECd1OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:15:05 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)) 18:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:15:05 INFO - Running setup.py (path:/tmp/pip-nBt1fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:15:05 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)) 18:15:05 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)) 18:15:05 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)) 18:15:05 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)) 18:15:05 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)) 18:15:05 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)) 18:15:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:15:05 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 18:15:05 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 18:15:05 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 18:15:05 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 18:15:05 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 18:15:05 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 18:15:07 INFO - Downloading blessings-1.6.tar.gz 18:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:15:07 INFO - Installing collected packages: blessings 18:15:07 INFO - Running setup.py install for blessings 18:15:07 INFO - Successfully installed blessings 18:15:07 INFO - Cleaning up... 18:15:08 INFO - Return code: 0 18:15:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:15:08 INFO - Reading from file tmpfile_stdout 18:15:08 INFO - Current package versions: 18:15:08 INFO - argparse == 1.2.1 18:15:08 INFO - blessings == 1.6 18:15:08 INFO - blobuploader == 1.2.4 18:15:08 INFO - docopt == 0.6.1 18:15:08 INFO - manifestparser == 1.1 18:15:08 INFO - mozInstall == 1.12 18:15:08 INFO - mozcrash == 0.17 18:15:08 INFO - mozdebug == 0.1 18:15:08 INFO - mozdevice == 0.48 18:15:08 INFO - mozfile == 1.2 18:15:08 INFO - mozhttpd == 0.7 18:15:08 INFO - mozinfo == 0.9 18:15:08 INFO - mozleak == 0.1 18:15:08 INFO - mozlog == 3.2 18:15:08 INFO - moznetwork == 0.27 18:15:08 INFO - mozprocess == 0.22 18:15:08 INFO - mozprofile == 0.28 18:15:08 INFO - mozrunner == 6.11 18:15:08 INFO - mozscreenshot == 0.1 18:15:08 INFO - mozsystemmonitor == 0.3 18:15:08 INFO - moztest == 0.7 18:15:08 INFO - mozversion == 1.4 18:15:08 INFO - psutil == 3.1.1 18:15:08 INFO - requests == 1.2.3 18:15:08 INFO - wsgiref == 0.1.2 18:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:08 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 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:15:08 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 18:15:08 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 18:15:08 INFO - Using env: {'DISPLAY': ':0', 18:15:08 INFO - 'HOME': '/home/cltbld', 18:15:08 INFO - 'LANG': 'en_US.UTF-8', 18:15:08 INFO - 'LANGUAGE': 'en_US:en', 18:15:08 INFO - 'LOGNAME': 'cltbld', 18:15:08 INFO - 'MAIL': '/var/mail/cltbld', 18:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:08 INFO - 'MOZ_NO_REMOTE': '1', 18:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:08 INFO - 'NO_EM_RESTART': '1', 18:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:08 INFO - 'PWD': '/builds/slave/test', 18:15:08 INFO - 'SHELL': '/bin/bash', 18:15:08 INFO - 'SHLVL': '1', 18:15:08 INFO - 'TERM': 'linux', 18:15:08 INFO - 'TMOUT': '86400', 18:15:08 INFO - 'USER': 'cltbld', 18:15:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:08 INFO - '_': '/tools/buildbot/bin/python'} 18:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 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)) 18:15:08 INFO - Cleaning up... 18:15:08 INFO - Return code: 0 18:15:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:08 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 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:15:08 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 18:15:08 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 18:15:08 INFO - Using env: {'DISPLAY': ':0', 18:15:08 INFO - 'HOME': '/home/cltbld', 18:15:08 INFO - 'LANG': 'en_US.UTF-8', 18:15:08 INFO - 'LANGUAGE': 'en_US:en', 18:15:08 INFO - 'LOGNAME': 'cltbld', 18:15:08 INFO - 'MAIL': '/var/mail/cltbld', 18:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:08 INFO - 'MOZ_NO_REMOTE': '1', 18:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:08 INFO - 'NO_EM_RESTART': '1', 18:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:08 INFO - 'PWD': '/builds/slave/test', 18:15:08 INFO - 'SHELL': '/bin/bash', 18:15:08 INFO - 'SHLVL': '1', 18:15:08 INFO - 'TERM': 'linux', 18:15:08 INFO - 'TMOUT': '86400', 18:15:08 INFO - 'USER': 'cltbld', 18:15:08 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:08 INFO - '_': '/tools/buildbot/bin/python'} 18:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:08 INFO - Downloading/unpacking jsonschema 18:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:15:10 INFO - Downloading/unpacking functools32 (from jsonschema) 18:15:10 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 18:15:10 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 18:15:10 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 18:15:10 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 18:15:10 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 18:15:10 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 18:15:10 INFO - Downloading functools32-3.2.3-2.tar.gz 18:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:15:10 INFO - warning: no files found matching '*.txt' 18:15:10 INFO - no previously-included directories found matching 'build' 18:15:10 INFO - no previously-included directories found matching 'dist' 18:15:10 INFO - no previously-included directories found matching '.git*' 18:15:10 INFO - Installing collected packages: jsonschema, functools32 18:15:10 INFO - Running setup.py install for functools32 18:15:10 INFO - warning: no files found matching '*.txt' 18:15:10 INFO - no previously-included directories found matching 'build' 18:15:10 INFO - no previously-included directories found matching 'dist' 18:15:10 INFO - no previously-included directories found matching '.git*' 18:15:10 INFO - Successfully installed jsonschema functools32 18:15:10 INFO - Cleaning up... 18:15:11 INFO - Return code: 0 18:15:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:15: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')]} 18:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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')]} 18:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc934e6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ed770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', '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 18:15: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', 'flake8'] in /builds/slave/test/build 18:15: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 flake8 18:15:11 INFO - Using env: {'DISPLAY': ':0', 18:15:11 INFO - 'HOME': '/home/cltbld', 18:15:11 INFO - 'LANG': 'en_US.UTF-8', 18:15:11 INFO - 'LANGUAGE': 'en_US:en', 18:15:11 INFO - 'LOGNAME': 'cltbld', 18:15:11 INFO - 'MAIL': '/var/mail/cltbld', 18:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:11 INFO - 'MOZ_NO_REMOTE': '1', 18:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:11 INFO - 'NO_EM_RESTART': '1', 18:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:11 INFO - 'PWD': '/builds/slave/test', 18:15:11 INFO - 'SHELL': '/bin/bash', 18:15:11 INFO - 'SHLVL': '1', 18:15:11 INFO - 'TERM': 'linux', 18:15:11 INFO - 'TMOUT': '86400', 18:15:11 INFO - 'USER': 'cltbld', 18:15:11 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:11 INFO - '_': '/tools/buildbot/bin/python'} 18:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:11 INFO - Downloading/unpacking flake8 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:15:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:15:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:15:13 INFO - no previously-included directories found matching 'docs/_build' 18:15:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:15:13 INFO - Running setup.py install for pep8 18:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:15:13 INFO - no previously-included directories found matching 'docs/_build' 18:15:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:15:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:15:14 INFO - Cleaning up... 18:15:14 INFO - Return code: 0 18:15:14 INFO - Running post-action listener: _resource_record_post_action 18:15:14 INFO - Running post-action listener: _start_resource_monitoring 18:15:14 INFO - Starting resource monitoring. 18:15:14 INFO - ##### 18:15:14 INFO - ##### Finished create-virtualenv step (success) 18:15:14 INFO - ##### 18:15:14 INFO - ##### 18:15:14 INFO - ##### Running install step. 18:15:14 INFO - ##### 18:15:14 INFO - Running pre-action listener: _resource_record_pre_action 18:15:14 INFO - Running main action method: install 18:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:15:14 INFO - Reading from file tmpfile_stdout 18:15:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:15:14 INFO - Reading from file tmpfile_stdout 18:15:14 INFO - Output received: 18:15:14 INFO - Usage: mozinstall [options] installer 18:15:14 INFO - Options: 18:15:14 INFO - -h, --help show this help message and exit 18:15:14 INFO - -d DEST, --destination=DEST 18:15:14 INFO - Directory to install application into. [default: 18:15:14 INFO - "/builds/slave/test"] 18:15:14 INFO - --app=APP Application being installed. [default: firefox] 18:15:14 INFO - mkdir: /builds/slave/test/build/application 18:15:14 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'] 18:15:14 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 18:15:30 INFO - Reading from file tmpfile_stdout 18:15:30 INFO - Output received: 18:15:30 INFO - /builds/slave/test/build/application/firefox/firefox 18:15:30 INFO - Running post-action listener: _resource_record_post_action 18:15:30 INFO - ##### 18:15:30 INFO - ##### Finished install step (success) 18:15:30 INFO - ##### 18:15:30 INFO - ##### 18:15:30 INFO - ##### Running run-tests step. 18:15:30 INFO - ##### 18:15:30 INFO - Running pre-action listener: _resource_record_pre_action 18:15:30 INFO - Running main action method: run_tests 18:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:15:30 INFO - Python 2.7.3 18:15:30 INFO - Return code: 0 18:15:30 INFO - grabbing minidump binary from tooltool 18:15:30 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')]} 18:15:30 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 0x237c9c0>, '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 0x237d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:15:30 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 18:15:30 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 18:15:30 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 18:15:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:15:30 INFO - Return code: 0 18:15:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:15:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:15:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:15:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:15:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:15:31 INFO - Return code: 0 18:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 18:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 18:15:31 INFO - Using env: {'DISPLAY': ':0', 18:15:31 INFO - 'HOME': '/home/cltbld', 18:15:31 INFO - 'LANG': 'en_US.UTF-8', 18:15:31 INFO - 'LANGUAGE': 'en_US:en', 18:15:31 INFO - 'LOGNAME': 'cltbld', 18:15:31 INFO - 'MAIL': '/var/mail/cltbld', 18:15:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:15:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:31 INFO - 'MOZ_NO_REMOTE': '1', 18:15:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:31 INFO - 'NO_EM_RESTART': '1', 18:15:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:31 INFO - 'PWD': '/builds/slave/test', 18:15:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:15:31 INFO - 'SHELL': '/bin/bash', 18:15:31 INFO - 'SHLVL': '1', 18:15:31 INFO - 'TERM': 'linux', 18:15:31 INFO - 'TMOUT': '86400', 18:15:31 INFO - 'USER': 'cltbld', 18:15:31 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543', 18:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:31 INFO - '_': '/tools/buildbot/bin/python'} 18:15:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 18:15:31 INFO - mozversion application_buildid: 20160531170040 18:15:31 INFO - mozversion application_changeset: 25321494921c824703a605127fb1f99b1faf5910 18:15:31 INFO - mozversion application_display_name: Nightly 18:15:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:15:31 INFO - mozversion application_name: Firefox 18:15:31 INFO - mozversion application_remotingname: firefox 18:15:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:15:31 INFO - mozversion application_vendor: Mozilla 18:15:31 INFO - mozversion application_version: 49.0a1 18:15:31 INFO - mozversion platform_buildid: 20160531170040 18:15:31 INFO - mozversion platform_changeset: 25321494921c824703a605127fb1f99b1faf5910 18:15:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:15:31 INFO - mozversion platform_version: 49.0a1 18:15:31 INFO - using testdate: 1464743731 18:15:31 INFO - actual date: 1464743731 18:15:31 INFO - starting webserver on 'localhost:38560' 18:15:31 INFO - SUITE-START | Running 2 tests 18:15:31 INFO - TEST-START | dromaeo_css 18:15:31 INFO - operating with platform_type : linux_ 18:15:31 INFO - Initialising browser for dromaeo_css test... 18:15:31 INFO - TEST-INFO | started process 5889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTls63u/profile http://localhost:38560/getInfo.html) 18:15:36 INFO - PROCESS | 5889 | __metrics Screen width/height:1600/1200 18:15:36 INFO - PROCESS | 5889 | colorDepth:24 18:15:36 INFO - PROCESS | 5889 | Browser inner width/height: 1024/697 18:15:36 INFO - PROCESS | 5889 | __metrics 18:15:37 ERROR - PROCESS | 5889 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 18:15:37 INFO - TEST-INFO | 5889: exit 0 18:15:37 INFO - Browser initialized. 18:15:37 INFO - Running cycle 1/1 for dromaeo_css test... 18:15:37 INFO - TEST-INFO | started process 6007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTls63u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:49 INFO - PROCESS | 6007 | RSS: Main: 167792640 18:15:49 INFO - PROCESS | 6007 | 18:16:39 INFO - PROCESS | 6007 | 1464743799564 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] 18:18:51 INFO - PROCESS | 6007 | Cycle 1(1): loaded http://localhost:38560/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38560/tests/dromaeo/cssquery-ext.html) 18:18:52 INFO - PROCESS | 6007 | RSS: Main: 171212800 18:18:52 INFO - PROCESS | 6007 | 18:21:54 INFO - PROCESS | 6007 | Cycle 1(1): loaded http://localhost:38560/tests/dromaeo/cssquery-ext.html (next: http://localhost:38560/tests/dromaeo/cssquery-jquery.html) 18:21:55 INFO - PROCESS | 6007 | RSS: Main: 170401792 18:21:55 INFO - PROCESS | 6007 | 18:24:57 INFO - PROCESS | 6007 | Cycle 1(1): loaded http://localhost:38560/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38560/tests/dromaeo/cssquery-mootools.html) 18:24:57 INFO - PROCESS | 6007 | RSS: Main: 171454464 18:24:57 INFO - PROCESS | 6007 | 18:27:59 INFO - PROCESS | 6007 | Cycle 1(1): loaded http://localhost:38560/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38560/tests/dromaeo/cssquery-prototype.html) 18:28:00 INFO - PROCESS | 6007 | RSS: Main: 168579072 18:28:00 INFO - PROCESS | 6007 | 18:31:02 INFO - PROCESS | 6007 | Cycle 1(1): loaded http://localhost:38560/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38560/tests/dromaeo/cssquery-yui.html) 18:31:03 INFO - PROCESS | 6007 | RSS: Main: 170532864 18:31:03 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | Cycle 1(1): loaded http://localhost:38560/tests/dromaeo/cssquery-yui.html (next: http://localhost:38560/tests/dromaeo/cssquery-dojo.html) 18:34:06 INFO - PROCESS | 6007 | RSS: Main: 171683840 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | __start_tp_report 18:34:06 INFO - PROCESS | 6007 | _x_x_mozilla_page_load 18:34:06 INFO - PROCESS | 6007 | _x_x_mozilla_page_load_details 18:34:06 INFO - PROCESS | 6007 | |i|pagename|runs| 18:34:06 INFO - PROCESS | 6007 | |0;dojo.html;2658.9867050664748;2691.2195463315634;2692.151972128779;2703.972960270398;2713.430179662271;4656.5809077183;4697.5302469753005;4707.529247075291;4746.596539294164;4803;4595.655325850558;4718.528147185289;4755.833545825897;4764.023375208083;4780.689255198409;4312.374705667684;4343.804528796196;4439.422875026242;4443.84446544371;4449.510553839075;4132.028973191298;4475.261581838992;4487.080148569536;4491.191585514606;4555.111753208126;4244.999999999969;4313.1804957058375;4316.309390497506;4343.869683909487;4399.78001099947;4300.247456695097;4302.182585308813;4327.32926396409;4336.56634336567;4372.672049596261;4335.349697545362;4357.673174511892;4358;4358.433403657536;4412.933805992912;4605.355250264965;4651.279051746985;4661.277501987197;4661.510541393139;4698.483166851644;5090.720010399464;5104.744762761847;5105.234214867763;5117.488251174853;5160.432352441266;5097.974510127426;5112.693238405707;5143.7685304161405;5147.562457191143;5150.459201783796;4771.665983381165;4785;4786.736729479912;4794.161021821237;4839.080574690833;5236.895262094737;5246.501582349671;5258.553022993088;5259.316288882497;5280.577553795687;4960.627952903546;4992.176290911959;5015.924761128586;5021.72380519075;5021.899562008739;5086.669366491166;5112.74436278192;5117.513836185556;5125.948740512622;5173.741312934413;4862.5380588844;4945.134601444733;4983.377077865267;5046.899062018739;5063.594912407072;4833.830815921426;4940;5017.82437614689;5025.547700706954;5039.77321020555;4215.220184265921;4220.07158425146;4222.387753775685;4276.379924910871;4281.2293787118615;3712.406015037581;3727.142757165813;3736.065983504124;3753.3619284721663;3803.8858834234466;4245.702800803976;4272.9359059614135;4300.80646370914;4326.545712700184;4338.219120558329;5144.9742751286;5160.354955630546;5167.612429067835;5186.273921650972;5227.242049902743;4307.56924307573;4325.7188282762145;4328.913421731548;4343.153085148366;4374.081442897027;4454.77726113693;4489.551044895485;4500.842470513517;4541.6593755468475;4544;4708.858734237979;4743.810247590058;4775.832845850378;4788.592969597554;4812.133815913169;4986.32684587576;5030.496950304941;5089.185730283137;5090.516400941905;5138.845834624967;4772.7136371817805;4804.42346918372;4814.277858321139;4823.589994850477;4834;5020.171671674133;5048.848534543969;5050.570701490267;5050.675675675705;5096.210087436453;4908.263760435963;5072.4673909239;5108.61685373591;5118.8976220476125;5173.948260517497;4795.184818580919;4905.190643543918;4947.579455746302;4983.476734942924;5027.522385373383;4928.778204980857;4934.703917764802;4944.233643785219;4944.75276236194;4951.653384263067;4674.649401294849;4822.373091498082;4865.051314993542;4896.36347274852;4931.358923340086;4941.2835138905375;4951.1088004158155;4972.825951091694;4985.027919555797;5040.017196646619;4849.684770489906;4856.077345304381;4864.270359446112;4871.244957031666;4924.556789888928 18:34:06 INFO - PROCESS | 6007 | |1;ext.html;551.422198207185;564.150952816012;589.3664310865818;592.1946153231605;621.2079598511899;33603.495947560776;38114;38231.808840955826;38273;38340.80829595848;39336.606633933654;39579;39818.60181398185;39993;40079.799601001956;7719.305262526372;7849.215078492133;7863.8034049148655;7865.252800983897;7905.604719764017;7776.727814526493;7870.685172593089;7871.881921771178;7883.645235964366;7892.210778922091;7888.526688398686;7903.723369682062;7933;7936.563489008102;7968.203179682015;7885.408594355417;7887.092984306763;7903.525788452711;7909.169537198598;7941.682332706656;7614.581198034106;7742;7777.688892444296;7784.766457006299;7785;28673.28316792076;36058.27883442317;36153.81923090394;36240.63759362399;36572.451413228824;3084.629844418662;3125.8124512529093;3300.5544251526217;3350.748693847971;3390.9996551017507;27829.304267393476;27900.441991160267;28613.57079643807;29240;30715.539266911015;3236.72487838534;3248.545203671488;3272.721818645418;3289.342131573695;3330.833458327098;210988;282018;282152;283570;284191;32621.673783262337;33981.32037359239;59967.40032599618;60347;60753.39246607477;35752.106197345274;35911.28177436489;35948.46077308842;36005.819970899975;36034;13083.934580327037;13194.802077968838;13202.207867527979;13227.603171904859;13236.07347485686;11777.352245626573;12015.699607509707;12033.097517686034;12060.758784824255;12073.15487915855;8155.5514446706;8188.467749596257;8205.220504052106;8292.12932642064;8301.501909885426;3181.5068664357063;3206.903792886217;3219.388316219911;3279.3277378137423;3281.245313577843;877.6270085213758;905.8414777413926;944.6552008516842;977.9902200977899;991.4497453913148;27424.271714723287;27921.581176282372;28093.157205283875;28181.859090704416;28234.152975410772;923.2014307623857;997.1374760831828;1004.7136566078633;1017.8218811707922;1045.5086109528509;14784.630384240265;15109.33002878159;15199.42059389113;15300.617484562976;15408.61478463025;357656;367031;368426;369177;369208;48428.5157148431;49373;49664.75167624139;49679;49720.751396242784;1210.2194084815244;1224.6570960131178;1238.6779437346354;1253.3232054690548;1262.4950019992077;26569.468610628064;27805.165845024683;28362.43275134527;28891.711082889742;29605.407891842475;47820.28269576029;48082;48316.7584162091;48522;48634.513654862996;361085;366621;370023;370252;370536;38230;38422;39027.609723902395;39042;39079.41380879232;41722.58277417308;42136.57863421326;42248;42398.576014239465;42587.787061065734;36525.26949460943;36609;37003.25993480169;37338.25323493569;37693.62306377011;35648;36350.81824590966;36500.45249321315;36575.63424365722;36588.45117323189;34973;35447.291054178255;35834.4624830633;35991.82004089963;37798.62201378061;27210.45579088447;29325.26686832761;30086.69913300839;30988.69011309948;31138;25276.241712748648;26050.609240861024;26123;26258;26264 18:34:06 INFO - PROCESS | 6007 | |2;jquery.html;378.59490345330494;378.75759513911083;379.52748827709496;385.74155315938316;389.2157303034384;10394.688159355213;10821.891781082188;10918.344899306046;10945.960133787288;15859.286332115054;16992.74510882338;17092;17974.640507189848;18109;18121.184546695396;5194.428612852593;5803.477687008169;5805.680687562182;5808.709564521757;5816.389279125694;5539.861503462425;5678.148277758328;5753.5684823638185;5756;5761.9423805762035;5727.914081288784;5735.426457354273;5750.971245143768;5756.395578464264;5764.7117644117625;5468.2891224141;5641.774329026834;5739.253896993385;5742.253507044099;5750.913736293959;5476.205950137248;5486.31421072366;5506.366767821712;5524.254225679522;5526.336839579236;21379.786202137933;21599;21796.237131700473;22290.665640015413;22306.553868922532;1908.5228692826793;1935.8354539864129;2018.8485863560293;2224.455008522906;2224.9666255006186;13096.86903130966;13816.101953372998;13976.231307278096;14505.492307769178;14845.925770371186;1811.7554130192386;1844.7232915062714;1902.6765449873556;1908.0459770114942;1925.2491528303972;74571;75897;76791.61604191943;78254.60872695658;79752.60123699345;15549.756019518638;16193.919030404773;16407.91796041036;16551.6689666206;16587.419440319532;28916.27709307284;29102;29389;29394.559081613792;29395.11814645564;8767.123287671182;9205.12551307638;9265.629374825066;9488.715338539854;9556.617735290649;7459.738909138263;7591.544507329578;7615.390768738488;7617.69529218825;7705.653245603961;8163.55100469468;8354.958225208835;8371.044080772706;8499.320054395634;8605.440646357967;3285.14586207583;3319.302946381287;3323.6373087034685;3375.274316022067;3445.776024558396;386.9613038696164;389.72134923529813;420.7748854362901;785.2775446589152;949.8100379924043;9927.751806204758;10582.100521455608;10753.247272690993;10754.300970436896;10787.406692631981;405.1633377076328;426.81984313373545;434.68702534175344;437.6148988889757;446.1434046630477;5133.23001549763;5689.68706721126;5810.738516766755;5889.705514724333;5909.3204281507315;398441;400097;401596;412492;415472;49621.25568116481;54876.72561637166;79549.60225198953;79815.60092199502;80176;437.74610725778973;442.32103720788433;443.6605996412747;446.56683017473;446.75428514316997;14660.340284687429;15055;15336.463223787114;16068.5982850425;16488.752668709738;35681.64318356783;36034.63965360313;36543.45184822283;36626.26747464982;36971.44542831914;45870.77064614656;48228;48710.26934596055;49040.2643960348;49163.75418122886;6259.906101408574;6509.804705858832;6655.001749737578;6712.765053223114;6732.360425759545;8816.603252853509;10035.598576056876;10627.468626568796;10765.192610554082;11002.50488727993;9010.601588990065;9286.442813431217;9407.059294070537;9425.104615061558;9444.85832712496;4600.907981840412;7960.681572737026;9046.864297035418;9049.77375565616;9158.267338612763;9207.171354577853;9295;9296.628134874529;9689.12797848197;9723.951380243054;6438.839029024124;6607.900881486878;6628.502862285444;6641.634710090992;6724.966375168093;8656;8975.332826930091;9018.462408196394;9023.097690230925;9200.171984521425 18:34:06 INFO - PROCESS | 6007 | |3;mootools.html;1399.7970294307327;1415.3347926474557;1556.3618916244343;1751.7197248440252;1753.5528440247735;6970.128733908262;7651.311381975621;7666.578338191397;8167.591620418985;8198.057223419308;7745.225477452266;8013.879791803128;8026.197380261986;8080.757577272677;8090.190980901922;2130.2970019893396;2170.4899348653053;2185.0604240176717;2187.431267870349;2188.146622817095;2116.2064225915283;2161.2867753641262;2167.111484291441;2173.315405647224;2190.123950419837;2169.7070895429074;2210.596271367677;2212.026708248374;2220.0786673530465;2221.0227499900075;2114.1754715660904;2132.680097985299;2134.0503475953205;2136.2096024470966;2142.8714277143267;2112.0706888968803;2142.7750086240876;2154.439845640145;2156.7843215678463;2158.115172779169;7962.681492740284;8031.558264295461;8034.638441270157;8053.07389650186;8079.353651707849;4348.652107831366;4471.6646251531265;4584.404027476407;4650.4186976627925;4654.837080702159;2837.120492647265;2902.0568315297614;2928.824270543753;2982.3140677644265;3008.669046404894;848.1815048478187;873;890.3767362846033;893.4058850864168;902.6615019367737;10757.462126893703;10784.514696838662;10811.18916081297;10820.837687434694;10834.620788272372;4167.874963751093;4236.915261694749;4297.183535128315;4302.397664326997;4350.499692535399;9222.031686672937;9224.215941644901;9260.305477089245;9262.166405023445;9276.11876871696;4551.7724113794175;4620.0990806793025;4636.35091087248;4698.365720627671;4715.009847931904;3714.925701486009;4063.187362527506;4209.5790420957655;4254.723442976197;4277.2087163874785;3722.813859307024;3732.8320225589914;3779.7921114338424;3810.314143454205;3868.516435445569;1121.7588218532892;1175.2889501851428;1177.5407591039502;1190.3691043746828;1197.6047904191596;791.5329955326386;793.8332950080433;800.4876878797575;801.3428988229713;816.5508970066439;5146.150885103991;5216.63483556155;5263.078961181778;5280.102382594968;5290.523852853262;399.86204759357975;402.60745772871803;412.38348668739826;413.8841124485149;430.43182998441756;3735.477033215352;3844.96155038446;3955.980220098881;3961.900952476211;3989.2221016901426;9529.857052144085;9981.650642227487;9982.900170998197;10046.04562566555;10059.08877313308;9065.093490651014;9494.810103797885;9508.144267016001;9845.60617575289;9958.950205248928;7343.3758130558435;7458.85082298351;7499.062617172854;7500.812479688051;7545.094588649397;5435.83692489226;5633.577481688808;5641.153826925994;5662.8301150965535;5714.542836572981;8899.15458031486;8919.821603568022;9024.548772561215;9027.638894444148;9031.232345250728;8798.34012449056;9013.414128081653;9144.268458523435;9232.122948319899;9285.257179425766;6771.45828333742;6832.350926661959;7014.228434872262;7014.929850701632;7019.333163349474;7567.621618919142;7573.697052118074;7576.621168941641;7588.013558237394;7629.0845098588525;6593.241777195684;6774.729010839511;6785.728570857111;6802.217744959393;6842.657867106725;6750.763723269662;6794.72821087151;6801.2858649841055;6805.727770889109;6836.316368363124;6578.572392794453;6596.142501474777;6626.337366263335;6631.767888123893;6634.436072933661;4872.488388719134;4927.507249275044;4934.703917764946;4952.77712502931;4991.001799640014;4925.21196608541;4930.556249937523;4974.228994505857;4982.701037937735;5011.523905228997 18:34:06 INFO - PROCESS | 6007 | |4;prototype.html;307.21200121687866;309.20842642834344;310.2646727256402;316.50783032384635;317.279774910952;5060.2662613921;5079.3142925705015;5092.79628814847;5096.592272618191;5108.284840122381;4992.500749925015;4996.701517302036;4999.475055119215;5014.42334131575;5024.949750502494;3736.4208547675153;3750.4374343848367;3858.961410385902;3862.7832232846563;3872.9155836365862;3826.387777955528;3832.13776900198;3833.4824798652244;3843.903902402434;3851.2490064437447;3820.5033345665024;3822.311983842907;3828.3300422426105;3840.578985775253;3849.576546579874;3603.8198090095652;3811.752236104672;3818.713596480261;3823;3849.8075096245075;3357.7145942594666;3371.651339464234;3373.089265898194;3374.797512149279;3377.1219482934366;4753.595944344735;4776.235802271654;4776.593989510896;4785.846369133904;4790.736509491977;4418.381426600278;4418.911621767579;4431.6233120184825;4440.666949978765;4441.133978874121;5023.296738456619;5247.47525247476;5248.895022099575;5260;5330.600204984603;3714.7771133732062;3716.9256614867822;3728.328900797855;3730.664240218366;3762.849486020556;5430.8370748877205;5504.862378440531;5514.283143191399;5535.612507124503;5550.777968881281;3560.643935606419;3759.041444431707;3795.16506368604;3818.2172654606293;3827.4067519534515;3852.499175107218;3870.2970692895037;3877.263319969197;3879.0690234343556;3885.4754608128105;4433.844815431445;4437.29003359461;4442.644588432918;4442.8667139985855;4451.488078870972;4992.326035985168;5231.973840130851;5282.603804714662;5322.3879253885525;5329.987302412529;1325.7083441642824;1342.812006319116;1348.8044233586074;1351.304078399625;1352.2427440633278;818.165471219353;845.3701992015865;846.7544412120416;858.6393714639867;862.4738909265343;4359.2807186813825;4438.689291749546;4479.484859241164;4484.775761211927;4497.977510112429;5380.811671591476;5389.434109418533;5413.539849112791;5417.214503896913;5425.891482170335;4439.667024973075;4492.595666390041;4502.302143167814;4521.208788462006;4549.4986654403965;2770.612114303999;2874.5257032589807;2883.2791802049487;2896.551034589642;2902.593636890837;5027.737518116789;5086.9745651271505;5095.949040509548;5097.61767867404;5098.923516147261;5297.8145764898045;5473.7263136843;5510.256115424447;5518.33779946409;5569.944300556943;5101.265569706317;5116.590672746246;5140.845774626767;5150.459201783834;5161.483851614808;5355.571554275571;5357.919631205457;5392.191171324333;5410.350757908918;5425.348958125051;4965.528274813887;5259.63182577216;5265.763040663256;5340.652857564246;5370.624056316176;5111.897762044812;5151;5155.742212889416;5159.664621799571;5185.351831021122;3888.6473683421123;3918.2555314490155;3918.451416801593;3926.1755031443718;3947;5149.253358263106;5454.400015998158;5476.479734425223;5489.204065410573;5515.200295957144;5273.182656688219;5292.391374991926;5298.549623282064;5301.628885978099;5321.680699158062;5305.416404195613;5345.705986170798;5347.465253474621;5371.576532219044;5383.407825139153;5135.768890399866;5223.4515375884985;5223.738813059408;5231.29377534028;5249.973750131225;5086.21163719624;5133.897322053613;5310.787568497217;5312.760925758427;5356.250124982584;5159.432462429205;5165;5180.300659410931;5199.71401572902;5213.687178769286 18:34:06 INFO - PROCESS | 6007 | |5;yui.html;599.9490043346316;640.3532432243433;650.8730797494491;655.3151956205766;695.2039914298128;12030.759384812309;12266.570670026551;12401.503939842396;12402.503899844007;12414.751704965895;11914;11939.223950443215;11951.820722689166;11959.940200298986;12013.939930300357;624.8875202463555;763.2482005224849;782.8082119880637;799.4563696686251;800.655718041242;802.5866678660494;806.2260230179006;808.127222599594;808.292743849132;810.278851821879;834.0491839303199;837.3719710217337;838.2330167896367;839.6179738219096;840.1220724343045;827.4910929778204;828.6726742936567;830.1159265382348;830.900291964965;832.429785596865;610.6732897899647;613.7238242790718;614.0543562913108;615.0466776496413;616.7101462312706;11724.941375293154;11765.294082355085;11771.705707357385;11800.586979455678;11808.586699465563;12658.683532911751;13032.218066916015;13063.738725225538;13137.474501019948;13326.466941322433;10369.792604147875;10391.948040259826;10406.843897341547;10412.791744165073;10418.166546676248;3308.5698859148397;3323.7507186961075;3337.2491189482416;3398.9830050849587;3467.2025434150287;47029.764851175525;47592.52407475915;47872;51026.23460648093;51758.96482070375;10148.441835699108;10183.083522483012;10417.427041512638;10434.060934515779;10826.35041897473;18749.90625046866;18794.15426305792;18860.05699715036;18953.90523047376;19072.332468363817;6816.965915170393;6929.757458488929;6937.167539895144;6980.650967451607;7117.71529138839;3760.924781504409;3776.3580191367532;3795.5065841440437;3865.072382628149;3904.06302487401;2736.097087960968;2834.7165283471486;2835.305350189217;3257.674232576723;3414.078198886287;590.3329237961076;591.2904514582518;600.4115966352998;602.1509671363357;603.2549800995766;547.4334064243488;631.4380201620561;633.9683015849189;646.9353064693493;649.3474058571201;8223;8557.78605534854;8574.914250857537;8714.956425217833;8777.29781617469;553.5156737854378;572.7794799002414;580.4021857486796;598.4225222660153;632.3044650884083;3946.1713040261293;4041.7574945503366;4056.20903923732;4114.663418335729;4115.670746340285;62876;63481.682591586745;64315.356846431874;64433.67783161054;64623.67688161623;54911.72544137254;55343.446565534636;55657.72171139118;56241.43758562362;56438;49212.50787492151;49970.0005999878;50007.499925001015;50599.494005060216;50707;7809.687612495663;7810.524316679023;7838.686452542062;7918.881216781638;8034.799130021796;32546;32697.673023270414;33277.83361083179;33480.49779253362;33689.831550842086;39489.60510394859;40380.59619403768;44077.11845763131;44347.77826110849;44529.332060018474;10432.58269669235;10524.210684198562;10542.420166890895;10584.259101862795;10587.100096491884;10601.41692206936;10921.660814537163;10984.793736075699;11035.613753518588;11128.054115400282;9951.104400603981;9996.750081247736;10055.547500362354;10230.386176829414;10387.428691422045;9452.763680908032;9574.234061274941;9598;9607.423554586747;9615.375000625218;9784.657536986171;10038.799224015625;10044.447555384231;10062.39625622465;10066.44634545107;8825.985011723735;8862.77843053903;8886.155815197546;9015;9124;8689.956550217208;8957.955210223907;9080.40977336471;9120.863187052068;9401.10689484498 18:34:06 INFO - PROCESS | 6007 | __end_tp_report 18:34:06 INFO - PROCESS | 6007 | __start_cc_report 18:34:06 INFO - PROCESS | 6007 | _x_x_mozilla_cycle_collect,404 18:34:06 INFO - PROCESS | 6007 | __end_cc_report 18:34:06 INFO - PROCESS | 6007 | __startTimestamp1464744846295__endTimestamp 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | ------- Summary: start ------- 18:34:06 INFO - PROCESS | 6007 | Number of tests: 6 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | [#0] dojo.html Cycles:165 Average:4686.36 Median:4812.13 stddev:497.19 (10.3%) stddev-sans-first:472.60 18:34:06 INFO - PROCESS | 6007 | Values: 2659.0 2691.2 2692.2 2704.0 2713.4 4656.6 4697.5 4707.5 4746.6 4803.0 4595.7 4718.5 4755.8 4764.0 4780.7 4312.4 4343.8 4439.4 4443.8 4449.5 4132.0 4475.3 4487.1 4491.2 4555.1 4245.0 4313.2 4316.3 4343.9 4399.8 4300.2 4302.2 4327.3 4336.6 4372.7 4335.3 4357.7 4358.0 4358.4 4412.9 4605.4 4651.3 4661.3 4661.5 4698.5 5090.7 5104.7 5105.2 5117.5 5160.4 5098.0 5112.7 5143.8 5147.6 5150.5 4771.7 4785.0 4786.7 4794.2 4839.1 5236.9 5246.5 5258.6 5259.3 5280.6 4960.6 4992.2 5015.9 5021.7 5021.9 5086.7 5112.7 5117.5 5125.9 5173.7 4862.5 4945.1 4983.4 5046.9 5063.6 4833.8 4940.0 5017.8 5025.5 5039.8 4215.2 4220.1 4222.4 4276.4 4281.2 3712.4 3727.1 3736.1 3753.4 3803.9 4245.7 4272.9 4300.8 4326.5 4338.2 5145.0 5160.4 5167.6 5186.3 5227.2 4307.6 4325.7 4328.9 4343.2 4374.1 4454.8 4489.6 4500.8 4541.7 4544.0 4708.9 4743.8 4775.8 4788.6 4812.1 4986.3 5030.5 5089.2 5090.5 5138.8 4772.7 4804.4 4814.3 4823.6 4834.0 5020.2 5048.8 5050.6 5050.7 5096.2 4908.3 5072.5 5108.6 5118.9 5173.9 4795.2 4905.2 4947.6 4983.5 5027.5 4928.8 4934.7 4944.2 4944.8 4951.7 4674.6 4822.4 4865.1 4896.4 4931.4 4941.3 4951.1 4972.8 4985.0 5040.0 4849.7 4856.1 4864.3 4871.2 4924.6 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | [#1] ext.html Cycles:180 Average:48056.95 Median:36574.04 stddev:89119.51 (243.7%) stddev-sans-first:89298.13 18:34:06 INFO - PROCESS | 6007 | Values: 551.4 564.2 589.4 592.2 621.2 33603.5 38114.0 38231.8 38273.0 38340.8 39336.6 39579.0 39818.6 39993.0 40079.8 7719.3 7849.2 7863.8 7865.3 7905.6 7776.7 7870.7 7871.9 7883.6 7892.2 7888.5 7903.7 7933.0 7936.6 7968.2 7885.4 7887.1 7903.5 7909.2 7941.7 7614.6 7742.0 7777.7 7784.8 7785.0 28673.3 36058.3 36153.8 36240.6 36572.5 3084.6 3125.8 3300.6 3350.7 3391.0 27829.3 27900.4 28613.6 29240.0 30715.5 3236.7 3248.5 3272.7 3289.3 3330.8 210988.0 282018.0 282152.0 283570.0 284191.0 32621.7 33981.3 59967.4 60347.0 60753.4 35752.1 35911.3 35948.5 36005.8 36034.0 13083.9 13194.8 13202.2 13227.6 13236.1 11777.4 12015.7 12033.1 12060.8 12073.2 8155.6 8188.5 8205.2 8292.1 8301.5 3181.5 3206.9 3219.4 3279.3 3281.2 877.6 905.8 944.7 978.0 991.4 27424.3 27921.6 28093.2 28181.9 28234.2 923.2 997.1 1004.7 1017.8 1045.5 14784.6 15109.3 15199.4 15300.6 15408.6 357656.0 367031.0 368426.0 369177.0 369208.0 48428.5 49373.0 49664.8 49679.0 49720.8 1210.2 1224.7 1238.7 1253.3 1262.5 26569.5 27805.2 28362.4 28891.7 29605.4 47820.3 48082.0 48316.8 48522.0 48634.5 361085.0 366621.0 370023.0 370252.0 370536.0 38230.0 38422.0 39027.6 39042.0 39079.4 41722.6 42136.6 42248.0 42398.6 42587.8 36525.3 36609.0 37003.3 37338.3 37693.6 35648.0 36350.8 36500.5 36575.6 36588.5 34973.0 35447.3 35834.5 35991.8 37798.6 27210.5 29325.3 30086.7 30988.7 31138.0 25276.2 26050.6 26123.0 26258.0 26264.0 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | [#2] jquery.html Cycles:180 Average:25014.08 Median:49102.01 stddev:66874.65 (136.2%) stddev-sans-first:67036.67 18:34:06 INFO - PROCESS | 6007 | Values: 378.6 378.8 379.5 385.7 389.2 10394.7 10821.9 10918.3 10946.0 15859.3 16992.7 17092.0 17974.6 18109.0 18121.2 5194.4 5803.5 5805.7 5808.7 5816.4 5539.9 5678.1 5753.6 5756.0 5761.9 5727.9 5735.4 5751.0 5756.4 5764.7 5468.3 5641.8 5739.3 5742.3 5750.9 5476.2 5486.3 5506.4 5524.3 5526.3 21379.8 21599.0 21796.2 22290.7 22306.6 1908.5 1935.8 2018.8 2224.5 2225.0 13096.9 13816.1 13976.2 14505.5 14845.9 1811.8 1844.7 1902.7 1908.0 1925.2 74571.0 75897.0 76791.6 78254.6 79752.6 15549.8 16193.9 16407.9 16551.7 16587.4 28916.3 29102.0 29389.0 29394.6 29395.1 8767.1 9205.1 9265.6 9488.7 9556.6 7459.7 7591.5 7615.4 7617.7 7705.7 8163.6 8355.0 8371.0 8499.3 8605.4 3285.1 3319.3 3323.6 3375.3 3445.8 387.0 389.7 420.8 785.3 949.8 9927.8 10582.1 10753.2 10754.3 10787.4 405.2 426.8 434.7 437.6 446.1 5133.2 5689.7 5810.7 5889.7 5909.3 398441.0 400097.0 401596.0 412492.0 415472.0 49621.3 54876.7 79549.6 79815.6 80176.0 437.7 442.3 443.7 446.6 446.8 14660.3 15055.0 15336.5 16068.6 16488.8 35681.6 36034.6 36543.5 36626.3 36971.4 45870.8 48228.0 48710.3 49040.3 49163.8 6259.9 6509.8 6655.0 6712.8 6732.4 8816.6 10035.6 10627.5 10765.2 11002.5 9010.6 9286.4 9407.1 9425.1 9444.9 4600.9 7960.7 9046.9 9049.8 9158.3 9207.2 9295.0 9296.6 9689.1 9724.0 6438.8 6607.9 6628.5 6641.6 6725.0 8656.0 8975.3 9018.5 9023.1 9200.2 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | [#3] mootools.html Cycles:180 Average:5225.63 Median:5001.26 stddev:2945.28 (58.9%) stddev-sans-first:2939.51 18:34:06 INFO - PROCESS | 6007 | Values: 1399.8 1415.3 1556.4 1751.7 1753.6 6970.1 7651.3 7666.6 8167.6 8198.1 7745.2 8013.9 8026.2 8080.8 8090.2 2130.3 2170.5 2185.1 2187.4 2188.1 2116.2 2161.3 2167.1 2173.3 2190.1 2169.7 2210.6 2212.0 2220.1 2221.0 2114.2 2132.7 2134.1 2136.2 2142.9 2112.1 2142.8 2154.4 2156.8 2158.1 7962.7 8031.6 8034.6 8053.1 8079.4 4348.7 4471.7 4584.4 4650.4 4654.8 2837.1 2902.1 2928.8 2982.3 3008.7 848.2 873.0 890.4 893.4 902.7 10757.5 10784.5 10811.2 10820.8 10834.6 4167.9 4236.9 4297.2 4302.4 4350.5 9222.0 9224.2 9260.3 9262.2 9276.1 4551.8 4620.1 4636.4 4698.4 4715.0 3714.9 4063.2 4209.6 4254.7 4277.2 3722.8 3732.8 3779.8 3810.3 3868.5 1121.8 1175.3 1177.5 1190.4 1197.6 791.5 793.8 800.5 801.3 816.6 5146.2 5216.6 5263.1 5280.1 5290.5 399.9 402.6 412.4 413.9 430.4 3735.5 3845.0 3956.0 3961.9 3989.2 9529.9 9981.7 9982.9 10046.0 10059.1 9065.1 9494.8 9508.1 9845.6 9959.0 7343.4 7458.9 7499.1 7500.8 7545.1 5435.8 5633.6 5641.2 5662.8 5714.5 8899.2 8919.8 9024.5 9027.6 9031.2 8798.3 9013.4 9144.3 9232.1 9285.3 6771.5 6832.4 7014.2 7014.9 7019.3 7567.6 7573.7 7576.6 7588.0 7629.1 6593.2 6774.7 6785.7 6802.2 6842.7 6750.8 6794.7 6801.3 6805.7 6836.3 6578.6 6596.1 6626.3 6631.8 6634.4 4872.5 4927.5 4934.7 4952.8 4991.0 4925.2 4930.6 4974.2 4982.7 5011.5 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | [#4] prototype.html Cycles:180 Average:4347.65 Median:5018.86 stddev:1279.25 (25.5%) stddev-sans-first:1246.37 18:34:06 INFO - PROCESS | 6007 | Values: 307.2 309.2 310.3 316.5 317.3 5060.3 5079.3 5092.8 5096.6 5108.3 4992.5 4996.7 4999.5 5014.4 5024.9 3736.4 3750.4 3859.0 3862.8 3872.9 3826.4 3832.1 3833.5 3843.9 3851.2 3820.5 3822.3 3828.3 3840.6 3849.6 3603.8 3811.8 3818.7 3823.0 3849.8 3357.7 3371.7 3373.1 3374.8 3377.1 4753.6 4776.2 4776.6 4785.8 4790.7 4418.4 4418.9 4431.6 4440.7 4441.1 5023.3 5247.5 5248.9 5260.0 5330.6 3714.8 3716.9 3728.3 3730.7 3762.8 5430.8 5504.9 5514.3 5535.6 5550.8 3560.6 3759.0 3795.2 3818.2 3827.4 3852.5 3870.3 3877.3 3879.1 3885.5 4433.8 4437.3 4442.6 4442.9 4451.5 4992.3 5232.0 5282.6 5322.4 5330.0 1325.7 1342.8 1348.8 1351.3 1352.2 818.2 845.4 846.8 858.6 862.5 4359.3 4438.7 4479.5 4484.8 4498.0 5380.8 5389.4 5413.5 5417.2 5425.9 4439.7 4492.6 4502.3 4521.2 4549.5 2770.6 2874.5 2883.3 2896.6 2902.6 5027.7 5087.0 5095.9 5097.6 5098.9 5297.8 5473.7 5510.3 5518.3 5569.9 5101.3 5116.6 5140.8 5150.5 5161.5 5355.6 5357.9 5392.2 5410.4 5425.3 4965.5 5259.6 5265.8 5340.7 5370.6 5111.9 5151.0 5155.7 5159.7 5185.4 3888.6 3918.3 3918.5 3926.2 3947.0 5149.3 5454.4 5476.5 5489.2 5515.2 5273.2 5292.4 5298.5 5301.6 5321.7 5305.4 5345.7 5347.5 5371.6 5383.4 5135.8 5223.5 5223.7 5231.3 5250.0 5086.2 5133.9 5310.8 5312.8 5356.3 5159.4 5165.0 5180.3 5199.7 5213.7 18:34:06 INFO - PROCESS | 6007 | 18:34:06 INFO - PROCESS | 6007 | [#5] yui.html Cycles:180 Average:13789.09 Median:51392.60 stddev:16951.84 (33.0%) stddev-sans-first:16970.46 18:34:06 INFO - PROCESS | 6007 | Values: 599.9 640.4 650.9 655.3 695.2 12030.8 12266.6 12401.5 12402.5 12414.8 11914.0 11939.2 11951.8 11959.9 12013.9 624.9 763.2 782.8 799.5 800.7 802.6 806.2 808.1 808.3 810.3 834.0 837.4 838.2 839.6 840.1 827.5 828.7 830.1 830.9 832.4 610.7 613.7 614.1 615.0 616.7 11724.9 11765.3 11771.7 11800.6 11808.6 12658.7 13032.2 13063.7 13137.5 13326.5 10369.8 10391.9 10406.8 10412.8 10418.2 3308.6 3323.8 3337.2 3399.0 3467.2 47029.8 47592.5 47872.0 51026.2 51759.0 10148.4 10183.1 10417.4 10434.1 10826.4 18749.9 18794.2 18860.1 18953.9 19072.3 6817.0 6929.8 6937.2 6980.7 7117.7 3760.9 3776.4 3795.5 3865.1 3904.1 2736.1 2834.7 2835.3 3257.7 3414.1 590.3 591.3 600.4 602.2 603.3 547.4 631.4 634.0 646.9 649.3 8223.0 8557.8 8574.9 8715.0 8777.3 553.5 572.8 580.4 598.4 632.3 3946.2 4041.8 4056.2 4114.7 4115.7 62876.0 63481.7 64315.4 64433.7 64623.7 54911.7 55343.4 55657.7 56241.4 56438.0 49212.5 49970.0 50007.5 50599.5 50707.0 7809.7 7810.5 7838.7 7918.9 8034.8 32546.0 32697.7 33277.8 33480.5 33689.8 39489.6 40380.6 44077.1 44347.8 44529.3 10432.6 10524.2 10542.4 10584.3 10587.1 10601.4 10921.7 10984.8 11035.6 11128.1 9951.1 9996.8 10055.5 10230.4 10387.4 9452.8 9574.2 9598.0 9607.4 9615.4 9784.7 10038.8 10044.4 10062.4 10066.4 8826.0 8862.8 8886.2 9015.0 9124.0 8690.0 8958.0 9080.4 9120.9 9401.1 18:34:06 INFO - PROCESS | 6007 | -------- Summary: end -------- 18:34:06 INFO - PROCESS | 6007 | 18:34:07 INFO - TEST-INFO | 6007: exit 0 18:34:07 INFO - TEST-OK | dromaeo_css | took 1115572ms 18:34:07 INFO - TEST-START | kraken 18:34:07 INFO - operating with platform_type : linux_ 18:34:07 INFO - Initialising browser for kraken test... 18:34:07 INFO - TEST-INFO | started process 6244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6sJMVR/profile http://localhost:38560/getInfo.html) 18:34:11 INFO - PROCESS | 6244 | __metrics Screen width/height:1600/1200 18:34:11 INFO - PROCESS | 6244 | colorDepth:24 18:34:11 INFO - PROCESS | 6244 | Browser inner width/height: 1024/697 18:34:11 INFO - PROCESS | 6244 | __metrics 18:34:12 ERROR - PROCESS | 6244 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 18:34:13 INFO - TEST-INFO | 6244: exit 0 18:34:13 INFO - Browser initialized. 18:34:13 INFO - Running cycle 1/1 for kraken test... 18:34:13 INFO - TEST-INFO | started process 6366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6sJMVR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:25 INFO - PROCESS | 6366 | RSS: Main: 167895040 18:34:25 INFO - PROCESS | 6366 | 18:34:28 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38560/tests/kraken/driver.html?testName=audio-beat-detection) 18:34:29 INFO - PROCESS | 6366 | RSS: Main: 172883968 18:34:29 INFO - PROCESS | 6366 | 18:34:31 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38560/tests/kraken/driver.html?testName=audio-dft) 18:34:32 INFO - PROCESS | 6366 | RSS: Main: 172019712 18:34:32 INFO - PROCESS | 6366 | 18:34:35 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38560/tests/kraken/driver.html?testName=audio-fft) 18:34:36 INFO - PROCESS | 6366 | RSS: Main: 167661568 18:34:36 INFO - PROCESS | 6366 | 18:34:38 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38560/tests/kraken/driver.html?testName=audio-oscillator) 18:34:38 INFO - PROCESS | 6366 | RSS: Main: 168501248 18:34:38 INFO - PROCESS | 6366 | 18:34:41 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38560/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:34:41 INFO - PROCESS | 6366 | RSS: Main: 168996864 18:34:41 INFO - PROCESS | 6366 | 18:34:44 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38560/tests/kraken/driver.html?testName=imaging-darkroom) 18:34:45 INFO - PROCESS | 6366 | RSS: Main: 169070592 18:34:45 INFO - PROCESS | 6366 | 18:34:49 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38560/tests/kraken/driver.html?testName=imaging-desaturate) 18:34:49 INFO - PROCESS | 6366 | RSS: Main: 166920192 18:34:49 INFO - PROCESS | 6366 | 18:34:52 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38560/tests/kraken/driver.html?testName=json-parse-financial) 18:34:53 INFO - PROCESS | 6366 | RSS: Main: 168075264 18:34:53 INFO - PROCESS | 6366 | 18:34:55 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38560/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:34:55 INFO - PROCESS | 6366 | RSS: Main: 168194048 18:34:55 INFO - PROCESS | 6366 | 18:34:57 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:34:58 INFO - PROCESS | 6366 | RSS: Main: 168411136 18:34:58 INFO - PROCESS | 6366 | 18:35:00 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:35:01 INFO - PROCESS | 6366 | RSS: Main: 168632320 18:35:01 INFO - PROCESS | 6366 | 18:35:04 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:35:04 INFO - PROCESS | 6366 | RSS: Main: 169009152 18:35:04 INFO - PROCESS | 6366 | 18:35:07 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:35:08 INFO - PROCESS | 6366 | RSS: Main: 168636416 18:35:08 INFO - PROCESS | 6366 | 18:35:09 INFO - PROCESS | 6366 | Cycle 1(1): loaded http://localhost:38560/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38560/tests/kraken/driver.html?testName=ai-astar) 18:35:10 INFO - PROCESS | 6366 | RSS: Main: 169398272 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | __start_tp_report 18:35:10 INFO - PROCESS | 6366 | _x_x_mozilla_page_load 18:35:10 INFO - PROCESS | 6366 | _x_x_mozilla_page_load_details 18:35:10 INFO - PROCESS | 6366 | |i|pagename|runs| 18:35:10 INFO - PROCESS | 6366 | |0;ai-astar;115;110;114;116;116;115;116;114;116;114 18:35:10 INFO - PROCESS | 6366 | |1;audio-beat-detection;163;131;156;177;143;166;156;136;194;133 18:35:10 INFO - PROCESS | 6366 | |2;audio-dft;162;163;163;178;163;163;164;163;164;163 18:35:10 INFO - PROCESS | 6366 | |3;audio-fft;76;76;79;147;77;75;75;76;162;76 18:35:10 INFO - PROCESS | 6366 | |4;audio-oscillator;86;86;149;84;85;86;140;86;85;137 18:35:10 INFO - PROCESS | 6366 | |5;imaging-gaussian-blur;117;117;118;117;117;118;117;117;117;118 18:35:10 INFO - PROCESS | 6366 | |6;imaging-darkroom;148;149;148;148;148;147;148;146;149;147 18:35:10 INFO - PROCESS | 6366 | |7;imaging-desaturate;95;96;96;96;95;96;95;96;95;95 18:35:10 INFO - PROCESS | 6366 | |8;json-parse-financial;65;64;66;63;65;64;66;65;65;64 18:35:10 INFO - PROCESS | 6366 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;65;66;66 18:35:10 INFO - PROCESS | 6366 | |10;stanford-crypto-aes;87;84;84;84;84;86;92;86;123;87 18:35:10 INFO - PROCESS | 6366 | |11;stanford-crypto-ccm;133;133;137;144;143;130;143;133;136;133 18:35:10 INFO - PROCESS | 6366 | |12;stanford-crypto-pbkdf2;173;172;178;174;177;170;172;175;170;171 18:35:10 INFO - PROCESS | 6366 | |13;stanford-crypto-sha256-iterative;68;73;68;76;67;69;66;67;66;66 18:35:10 INFO - PROCESS | 6366 | __end_tp_report 18:35:10 INFO - PROCESS | 6366 | __start_cc_report 18:35:10 INFO - PROCESS | 6366 | _x_x_mozilla_cycle_collect,936 18:35:10 INFO - PROCESS | 6366 | __end_cc_report 18:35:10 INFO - PROCESS | 6366 | __startTimestamp1464744910204__endTimestamp 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | ------- Summary: start ------- 18:35:10 INFO - PROCESS | 6366 | Number of tests: 14 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.50 stddev:1.84 (1.6%) stddev-sans-first:1.94 18:35:10 INFO - PROCESS | 6366 | Values: 115.0 110.0 114.0 116.0 116.0 115.0 116.0 114.0 116.0 114.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:159.50 stddev:20.42 (12.8%) stddev-sans-first:21.48 18:35:10 INFO - PROCESS | 6366 | Values: 163.0 131.0 156.0 177.0 143.0 166.0 156.0 136.0 194.0 133.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.00 stddev:4.74 (2.9%) stddev-sans-first:4.94 18:35:10 INFO - PROCESS | 6366 | Values: 162.0 163.0 163.0 178.0 163.0 163.0 164.0 163.0 164.0 163.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#3] audio-fft Cycles:10 Average:91.90 Median:76.00 stddev:33.20 (43.7%) stddev-sans-first:34.71 18:35:10 INFO - PROCESS | 6366 | Values: 76.0 76.0 79.0 147.0 77.0 75.0 75.0 76.0 162.0 76.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.50 stddev:27.49 (32.2%) stddev-sans-first:28.51 18:35:10 INFO - PROCESS | 6366 | Values: 86.0 86.0 149.0 84.0 85.0 86.0 140.0 86.0 85.0 137.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:35:10 INFO - PROCESS | 6366 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 18:35:10 INFO - PROCESS | 6366 | Values: 148.0 149.0 148.0 148.0 148.0 147.0 148.0 146.0 149.0 147.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:35:10 INFO - PROCESS | 6366 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 18:35:10 INFO - PROCESS | 6366 | Values: 65.0 64.0 66.0 63.0 65.0 64.0 66.0 65.0 65.0 64.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 18:35:10 INFO - PROCESS | 6366 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:86.00 stddev:11.95 (13.9%) stddev-sans-first:12.64 18:35:10 INFO - PROCESS | 6366 | Values: 87.0 84.0 84.0 84.0 84.0 86.0 92.0 86.0 123.0 87.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:136.50 stddev:5.08 (3.7%) stddev-sans-first:5.23 18:35:10 INFO - PROCESS | 6366 | Values: 133.0 133.0 137.0 144.0 143.0 130.0 143.0 133.0 136.0 133.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:2.78 (1.6%) stddev-sans-first:2.95 18:35:10 INFO - PROCESS | 6366 | Values: 173.0 172.0 178.0 174.0 177.0 170.0 172.0 175.0 170.0 171.0 18:35:10 INFO - PROCESS | 6366 | 18:35:10 INFO - PROCESS | 6366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:3.34 (4.9%) stddev-sans-first:3.54 18:35:10 INFO - PROCESS | 6366 | Values: 68.0 73.0 68.0 76.0 67.0 69.0 66.0 67.0 66.0 66.0 18:35:10 INFO - PROCESS | 6366 | -------- Summary: end -------- 18:35:10 INFO - PROCESS | 6366 | 18:35:11 INFO - TEST-INFO | 6366: exit 0 18:35:11 INFO - TEST-OK | kraken | took 64196ms 18:35:11 INFO - SUITE-END | took 1179s 18:35:11 INFO - Completed test suite (00:19:39) 18:35:11 INFO - javascript benchmark 18:35:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6303.387539897318, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2658.9867050664748, 2691.2195463315634, 2692.151972128779, 2703.972960270398, 2713.430179662271, 4656.5809077183, 4697.5302469753005, 4707.529247075291, 4746.596539294164, 4803.0, 4595.655325850558, 4718.528147185289, 4755.833545825897, 4764.023375208083, 4780.689255198409, 4312.374705667684, 4343.804528796196, 4439.422875026242, 4443.84446544371, 4449.510553839075, 4132.028973191298, 4475.261581838992, 4487.080148569536, 4491.191585514606, 4555.111753208126, 4244.999999999969, 4313.1804957058375, 4316.309390497506, 4343.869683909487, 4399.78001099947, 4300.247456695097, 4302.182585308813, 4327.32926396409, 4336.56634336567, 4372.672049596261, 4335.349697545362, 4357.673174511892, 4358.0, 4358.433403657536, 4412.933805992912, 4605.355250264965, 4651.279051746985, 4661.277501987197, 4661.510541393139, 4698.483166851644, 5090.720010399464, 5104.744762761847, 5105.234214867763, 5117.488251174853, 5160.432352441266, 5097.974510127426, 5112.693238405707, 5143.7685304161405, 5147.562457191143, 5150.459201783796, 4771.665983381165, 4785.0, 4786.736729479912, 4794.161021821237, 4839.080574690833, 5236.895262094737, 5246.501582349671, 5258.553022993088, 5259.316288882497, 5280.577553795687, 4960.627952903546, 4992.176290911959, 5015.924761128586, 5021.72380519075, 5021.899562008739, 5086.669366491166, 5112.74436278192, 5117.513836185556, 5125.948740512622, 5173.741312934413, 4862.5380588844, 4945.134601444733, 4983.377077865267, 5046.899062018739, 5063.594912407072, 4833.830815921426, 4940.0, 5017.82437614689, 5025.547700706954, 5039.77321020555, 4215.220184265921, 4220.07158425146, 4222.387753775685, 4276.379924910871, 4281.2293787118615, 3712.406015037581, 3727.142757165813, 3736.065983504124, 3753.3619284721663, 3803.8858834234466, 4245.702800803976, 4272.9359059614135, 4300.80646370914, 4326.545712700184, 4338.219120558329, 5144.9742751286, 5160.354955630546, 5167.612429067835, 5186.273921650972, 5227.242049902743, 4307.56924307573, 4325.7188282762145, 4328.913421731548, 4343.153085148366, 4374.081442897027, 4454.77726113693, 4489.551044895485, 4500.842470513517, 4541.6593755468475, 4544.0, 4708.858734237979, 4743.810247590058, 4775.832845850378, 4788.592969597554, 4812.133815913169, 4986.32684587576, 5030.496950304941, 5089.185730283137, 5090.516400941905, 5138.845834624967, 4772.7136371817805, 4804.42346918372, 4814.277858321139, 4823.589994850477, 4834.0, 5020.171671674133, 5048.848534543969, 5050.570701490267, 5050.675675675705, 5096.210087436453, 4908.263760435963, 5072.4673909239, 5108.61685373591, 5118.8976220476125, 5173.948260517497, 4795.184818580919, 4905.190643543918, 4947.579455746302, 4983.476734942924, 5027.522385373383, 4928.778204980857, 4934.703917764802, 4944.233643785219, 4944.75276236194, 4951.653384263067, 4674.649401294849, 4822.373091498082, 4865.051314993542, 4896.36347274852, 4931.358923340086, 4941.2835138905375, 4951.1088004158155, 4972.825951091694, 4985.027919555797, 5040.017196646619, 4849.684770489906, 4856.077345304381, 4864.270359446112, 4871.244957031666, 4924.556789888928], "value": 4654.860133342781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.422198207185, 564.150952816012, 589.3664310865818, 592.1946153231605, 621.2079598511899, 33603.495947560776, 38114.0, 38231.808840955826, 38273.0, 38340.80829595848, 39336.606633933654, 39579.0, 39818.60181398185, 39993.0, 40079.799601001956, 7719.305262526372, 7849.215078492133, 7863.8034049148655, 7865.252800983897, 7905.604719764017, 7776.727814526493, 7870.685172593089, 7871.881921771178, 7883.645235964366, 7892.210778922091, 7888.526688398686, 7903.723369682062, 7933.0, 7936.563489008102, 7968.203179682015, 7885.408594355417, 7887.092984306763, 7903.525788452711, 7909.169537198598, 7941.682332706656, 7614.581198034106, 7742.0, 7777.688892444296, 7784.766457006299, 7785.0, 28673.28316792076, 36058.27883442317, 36153.81923090394, 36240.63759362399, 36572.451413228824, 3084.629844418662, 3125.8124512529093, 3300.5544251526217, 3350.748693847971, 3390.9996551017507, 27829.304267393476, 27900.441991160267, 28613.57079643807, 29240.0, 30715.539266911015, 3236.72487838534, 3248.545203671488, 3272.721818645418, 3289.342131573695, 3330.833458327098, 210988.0, 282018.0, 282152.0, 283570.0, 284191.0, 32621.673783262337, 33981.32037359239, 59967.40032599618, 60347.0, 60753.39246607477, 35752.106197345274, 35911.28177436489, 35948.46077308842, 36005.819970899975, 36034.0, 13083.934580327037, 13194.802077968838, 13202.207867527979, 13227.603171904859, 13236.07347485686, 11777.352245626573, 12015.699607509707, 12033.097517686034, 12060.758784824255, 12073.15487915855, 8155.5514446706, 8188.467749596257, 8205.220504052106, 8292.12932642064, 8301.501909885426, 3181.5068664357063, 3206.903792886217, 3219.388316219911, 3279.3277378137423, 3281.245313577843, 877.6270085213758, 905.8414777413926, 944.6552008516842, 977.9902200977899, 991.4497453913148, 27424.271714723287, 27921.581176282372, 28093.157205283875, 28181.859090704416, 28234.152975410772, 923.2014307623857, 997.1374760831828, 1004.7136566078633, 1017.8218811707922, 1045.5086109528509, 14784.630384240265, 15109.33002878159, 15199.42059389113, 15300.617484562976, 15408.61478463025, 357656.0, 367031.0, 368426.0, 369177.0, 369208.0, 48428.5157148431, 49373.0, 49664.75167624139, 49679.0, 49720.751396242784, 1210.2194084815244, 1224.6570960131178, 1238.6779437346354, 1253.3232054690548, 1262.4950019992077, 26569.468610628064, 27805.165845024683, 28362.43275134527, 28891.711082889742, 29605.407891842475, 47820.28269576029, 48082.0, 48316.7584162091, 48522.0, 48634.513654862996, 361085.0, 366621.0, 370023.0, 370252.0, 370536.0, 38230.0, 38422.0, 39027.609723902395, 39042.0, 39079.41380879232, 41722.58277417308, 42136.57863421326, 42248.0, 42398.576014239465, 42587.787061065734, 36525.26949460943, 36609.0, 37003.25993480169, 37338.25323493569, 37693.62306377011, 35648.0, 36350.81824590966, 36500.45249321315, 36575.63424365722, 36588.45117323189, 34973.0, 35447.291054178255, 35834.4624830633, 35991.82004089963, 37798.62201378061, 27210.45579088447, 29325.26686832761, 30086.69913300839, 30988.69011309948, 31138.0, 25276.241712748648, 26050.609240861024, 26123.0, 26258.0, 26264.0], "value": 16878.56981482593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.59490345330494, 378.75759513911083, 379.52748827709496, 385.74155315938316, 389.2157303034384, 10394.688159355213, 10821.891781082188, 10918.344899306046, 10945.960133787288, 15859.286332115054, 16992.74510882338, 17092.0, 17974.640507189848, 18109.0, 18121.184546695396, 5194.428612852593, 5803.477687008169, 5805.680687562182, 5808.709564521757, 5816.389279125694, 5539.861503462425, 5678.148277758328, 5753.5684823638185, 5756.0, 5761.9423805762035, 5727.914081288784, 5735.426457354273, 5750.971245143768, 5756.395578464264, 5764.7117644117625, 5468.2891224141, 5641.774329026834, 5739.253896993385, 5742.253507044099, 5750.913736293959, 5476.205950137248, 5486.31421072366, 5506.366767821712, 5524.254225679522, 5526.336839579236, 21379.786202137933, 21599.0, 21796.237131700473, 22290.665640015413, 22306.553868922532, 1908.5228692826793, 1935.8354539864129, 2018.8485863560293, 2224.455008522906, 2224.9666255006186, 13096.86903130966, 13816.101953372998, 13976.231307278096, 14505.492307769178, 14845.925770371186, 1811.7554130192386, 1844.7232915062714, 1902.6765449873556, 1908.0459770114942, 1925.2491528303972, 74571.0, 75897.0, 76791.61604191943, 78254.60872695658, 79752.60123699345, 15549.756019518638, 16193.919030404773, 16407.91796041036, 16551.6689666206, 16587.419440319532, 28916.27709307284, 29102.0, 29389.0, 29394.559081613792, 29395.11814645564, 8767.123287671182, 9205.12551307638, 9265.629374825066, 9488.715338539854, 9556.617735290649, 7459.738909138263, 7591.544507329578, 7615.390768738488, 7617.69529218825, 7705.653245603961, 8163.55100469468, 8354.958225208835, 8371.044080772706, 8499.320054395634, 8605.440646357967, 3285.14586207583, 3319.302946381287, 3323.6373087034685, 3375.274316022067, 3445.776024558396, 386.9613038696164, 389.72134923529813, 420.7748854362901, 785.2775446589152, 949.8100379924043, 9927.751806204758, 10582.100521455608, 10753.247272690993, 10754.300970436896, 10787.406692631981, 405.1633377076328, 426.81984313373545, 434.68702534175344, 437.6148988889757, 446.1434046630477, 5133.23001549763, 5689.68706721126, 5810.738516766755, 5889.705514724333, 5909.3204281507315, 398441.0, 400097.0, 401596.0, 412492.0, 415472.0, 49621.25568116481, 54876.72561637166, 79549.60225198953, 79815.60092199502, 80176.0, 437.74610725778973, 442.32103720788433, 443.6605996412747, 446.56683017473, 446.75428514316997, 14660.340284687429, 15055.0, 15336.463223787114, 16068.5982850425, 16488.752668709738, 35681.64318356783, 36034.63965360313, 36543.45184822283, 36626.26747464982, 36971.44542831914, 45870.77064614656, 48228.0, 48710.26934596055, 49040.2643960348, 49163.75418122886, 6259.906101408574, 6509.804705858832, 6655.001749737578, 6712.765053223114, 6732.360425759545, 8816.603252853509, 10035.598576056876, 10627.468626568796, 10765.192610554082, 11002.50488727993, 9010.601588990065, 9286.442813431217, 9407.059294070537, 9425.104615061558, 9444.85832712496, 4600.907981840412, 7960.681572737026, 9046.864297035418, 9049.77375565616, 9158.267338612763, 9207.171354577853, 9295.0, 9296.628134874529, 9689.12797848197, 9723.951380243054, 6438.839029024124, 6607.900881486878, 6628.502862285444, 6641.634710090992, 6724.966375168093, 8656.0, 8975.332826930091, 9018.462408196394, 9023.097690230925, 9200.171984521425], "value": 8127.991222088518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.7970294307327, 1415.3347926474557, 1556.3618916244343, 1751.7197248440252, 1753.5528440247735, 6970.128733908262, 7651.311381975621, 7666.578338191397, 8167.591620418985, 8198.057223419308, 7745.225477452266, 8013.879791803128, 8026.197380261986, 8080.757577272677, 8090.190980901922, 2130.2970019893396, 2170.4899348653053, 2185.0604240176717, 2187.431267870349, 2188.146622817095, 2116.2064225915283, 2161.2867753641262, 2167.111484291441, 2173.315405647224, 2190.123950419837, 2169.7070895429074, 2210.596271367677, 2212.026708248374, 2220.0786673530465, 2221.0227499900075, 2114.1754715660904, 2132.680097985299, 2134.0503475953205, 2136.2096024470966, 2142.8714277143267, 2112.0706888968803, 2142.7750086240876, 2154.439845640145, 2156.7843215678463, 2158.115172779169, 7962.681492740284, 8031.558264295461, 8034.638441270157, 8053.07389650186, 8079.353651707849, 4348.652107831366, 4471.6646251531265, 4584.404027476407, 4650.4186976627925, 4654.837080702159, 2837.120492647265, 2902.0568315297614, 2928.824270543753, 2982.3140677644265, 3008.669046404894, 848.1815048478187, 873.0, 890.3767362846033, 893.4058850864168, 902.6615019367737, 10757.462126893703, 10784.514696838662, 10811.18916081297, 10820.837687434694, 10834.620788272372, 4167.874963751093, 4236.915261694749, 4297.183535128315, 4302.397664326997, 4350.499692535399, 9222.031686672937, 9224.215941644901, 9260.305477089245, 9262.166405023445, 9276.11876871696, 4551.7724113794175, 4620.0990806793025, 4636.35091087248, 4698.365720627671, 4715.009847931904, 3714.925701486009, 4063.187362527506, 4209.5790420957655, 4254.723442976197, 4277.2087163874785, 3722.813859307024, 3732.8320225589914, 3779.7921114338424, 3810.314143454205, 3868.516435445569, 1121.7588218532892, 1175.2889501851428, 1177.5407591039502, 1190.3691043746828, 1197.6047904191596, 791.5329955326386, 793.8332950080433, 800.4876878797575, 801.3428988229713, 816.5508970066439, 5146.150885103991, 5216.63483556155, 5263.078961181778, 5280.102382594968, 5290.523852853262, 399.86204759357975, 402.60745772871803, 412.38348668739826, 413.8841124485149, 430.43182998441756, 3735.477033215352, 3844.96155038446, 3955.980220098881, 3961.900952476211, 3989.2221016901426, 9529.857052144085, 9981.650642227487, 9982.900170998197, 10046.04562566555, 10059.08877313308, 9065.093490651014, 9494.810103797885, 9508.144267016001, 9845.60617575289, 9958.950205248928, 7343.3758130558435, 7458.85082298351, 7499.062617172854, 7500.812479688051, 7545.094588649397, 5435.83692489226, 5633.577481688808, 5641.153826925994, 5662.8301150965535, 5714.542836572981, 8899.15458031486, 8919.821603568022, 9024.548772561215, 9027.638894444148, 9031.232345250728, 8798.34012449056, 9013.414128081653, 9144.268458523435, 9232.122948319899, 9285.257179425766, 6771.45828333742, 6832.350926661959, 7014.228434872262, 7014.929850701632, 7019.333163349474, 7567.621618919142, 7573.697052118074, 7576.621168941641, 7588.013558237394, 7629.0845098588525, 6593.241777195684, 6774.729010839511, 6785.728570857111, 6802.217744959393, 6842.657867106725, 6750.763723269662, 6794.72821087151, 6801.2858649841055, 6805.727770889109, 6836.316368363124, 6578.572392794453, 6596.142501474777, 6626.337366263335, 6631.767888123893, 6634.436072933661, 4872.488388719134, 4927.507249275044, 4934.703917764946, 4952.77712502931, 4991.001799640014, 4925.21196608541, 4930.556249937523, 4974.228994505857, 4982.701037937735, 5011.523905228997], "value": 4118.590024679649, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.21200121687866, 309.20842642834344, 310.2646727256402, 316.50783032384635, 317.279774910952, 5060.2662613921, 5079.3142925705015, 5092.79628814847, 5096.592272618191, 5108.284840122381, 4992.500749925015, 4996.701517302036, 4999.475055119215, 5014.42334131575, 5024.949750502494, 3736.4208547675153, 3750.4374343848367, 3858.961410385902, 3862.7832232846563, 3872.9155836365862, 3826.387777955528, 3832.13776900198, 3833.4824798652244, 3843.903902402434, 3851.2490064437447, 3820.5033345665024, 3822.311983842907, 3828.3300422426105, 3840.578985775253, 3849.576546579874, 3603.8198090095652, 3811.752236104672, 3818.713596480261, 3823.0, 3849.8075096245075, 3357.7145942594666, 3371.651339464234, 3373.089265898194, 3374.797512149279, 3377.1219482934366, 4753.595944344735, 4776.235802271654, 4776.593989510896, 4785.846369133904, 4790.736509491977, 4418.381426600278, 4418.911621767579, 4431.6233120184825, 4440.666949978765, 4441.133978874121, 5023.296738456619, 5247.47525247476, 5248.895022099575, 5260.0, 5330.600204984603, 3714.7771133732062, 3716.9256614867822, 3728.328900797855, 3730.664240218366, 3762.849486020556, 5430.8370748877205, 5504.862378440531, 5514.283143191399, 5535.612507124503, 5550.777968881281, 3560.643935606419, 3759.041444431707, 3795.16506368604, 3818.2172654606293, 3827.4067519534515, 3852.499175107218, 3870.2970692895037, 3877.263319969197, 3879.0690234343556, 3885.4754608128105, 4433.844815431445, 4437.29003359461, 4442.644588432918, 4442.8667139985855, 4451.488078870972, 4992.326035985168, 5231.973840130851, 5282.603804714662, 5322.3879253885525, 5329.987302412529, 1325.7083441642824, 1342.812006319116, 1348.8044233586074, 1351.304078399625, 1352.2427440633278, 818.165471219353, 845.3701992015865, 846.7544412120416, 858.6393714639867, 862.4738909265343, 4359.2807186813825, 4438.689291749546, 4479.484859241164, 4484.775761211927, 4497.977510112429, 5380.811671591476, 5389.434109418533, 5413.539849112791, 5417.214503896913, 5425.891482170335, 4439.667024973075, 4492.595666390041, 4502.302143167814, 4521.208788462006, 4549.4986654403965, 2770.612114303999, 2874.5257032589807, 2883.2791802049487, 2896.551034589642, 2902.593636890837, 5027.737518116789, 5086.9745651271505, 5095.949040509548, 5097.61767867404, 5098.923516147261, 5297.8145764898045, 5473.7263136843, 5510.256115424447, 5518.33779946409, 5569.944300556943, 5101.265569706317, 5116.590672746246, 5140.845774626767, 5150.459201783834, 5161.483851614808, 5355.571554275571, 5357.919631205457, 5392.191171324333, 5410.350757908918, 5425.348958125051, 4965.528274813887, 5259.63182577216, 5265.763040663256, 5340.652857564246, 5370.624056316176, 5111.897762044812, 5151.0, 5155.742212889416, 5159.664621799571, 5185.351831021122, 3888.6473683421123, 3918.2555314490155, 3918.451416801593, 3926.1755031443718, 3947.0, 5149.253358263106, 5454.400015998158, 5476.479734425223, 5489.204065410573, 5515.200295957144, 5273.182656688219, 5292.391374991926, 5298.549623282064, 5301.628885978099, 5321.680699158062, 5305.416404195613, 5345.705986170798, 5347.465253474621, 5371.576532219044, 5383.407825139153, 5135.768890399866, 5223.4515375884985, 5223.738813059408, 5231.29377534028, 5249.973750131225, 5086.21163719624, 5133.897322053613, 5310.787568497217, 5312.760925758427, 5356.250124982584, 5159.432462429205, 5165.0, 5180.300659410931, 5199.71401572902, 5213.687178769286], "value": 3939.737859345395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9490043346316, 640.3532432243433, 650.8730797494491, 655.3151956205766, 695.2039914298128, 12030.759384812309, 12266.570670026551, 12401.503939842396, 12402.503899844007, 12414.751704965895, 11914.0, 11939.223950443215, 11951.820722689166, 11959.940200298986, 12013.939930300357, 624.8875202463555, 763.2482005224849, 782.8082119880637, 799.4563696686251, 800.655718041242, 802.5866678660494, 806.2260230179006, 808.127222599594, 808.292743849132, 810.278851821879, 834.0491839303199, 837.3719710217337, 838.2330167896367, 839.6179738219096, 840.1220724343045, 827.4910929778204, 828.6726742936567, 830.1159265382348, 830.900291964965, 832.429785596865, 610.6732897899647, 613.7238242790718, 614.0543562913108, 615.0466776496413, 616.7101462312706, 11724.941375293154, 11765.294082355085, 11771.705707357385, 11800.586979455678, 11808.586699465563, 12658.683532911751, 13032.218066916015, 13063.738725225538, 13137.474501019948, 13326.466941322433, 10369.792604147875, 10391.948040259826, 10406.843897341547, 10412.791744165073, 10418.166546676248, 3308.5698859148397, 3323.7507186961075, 3337.2491189482416, 3398.9830050849587, 3467.2025434150287, 47029.764851175525, 47592.52407475915, 47872.0, 51026.23460648093, 51758.96482070375, 10148.441835699108, 10183.083522483012, 10417.427041512638, 10434.060934515779, 10826.35041897473, 18749.90625046866, 18794.15426305792, 18860.05699715036, 18953.90523047376, 19072.332468363817, 6816.965915170393, 6929.757458488929, 6937.167539895144, 6980.650967451607, 7117.71529138839, 3760.924781504409, 3776.3580191367532, 3795.5065841440437, 3865.072382628149, 3904.06302487401, 2736.097087960968, 2834.7165283471486, 2835.305350189217, 3257.674232576723, 3414.078198886287, 590.3329237961076, 591.2904514582518, 600.4115966352998, 602.1509671363357, 603.2549800995766, 547.4334064243488, 631.4380201620561, 633.9683015849189, 646.9353064693493, 649.3474058571201, 8223.0, 8557.78605534854, 8574.914250857537, 8714.956425217833, 8777.29781617469, 553.5156737854378, 572.7794799002414, 580.4021857486796, 598.4225222660153, 632.3044650884083, 3946.1713040261293, 4041.7574945503366, 4056.20903923732, 4114.663418335729, 4115.670746340285, 62876.0, 63481.682591586745, 64315.356846431874, 64433.67783161054, 64623.67688161623, 54911.72544137254, 55343.446565534636, 55657.72171139118, 56241.43758562362, 56438.0, 49212.50787492151, 49970.0005999878, 50007.499925001015, 50599.494005060216, 50707.0, 7809.687612495663, 7810.524316679023, 7838.686452542062, 7918.881216781638, 8034.799130021796, 32546.0, 32697.673023270414, 33277.83361083179, 33480.49779253362, 33689.831550842086, 39489.60510394859, 40380.59619403768, 44077.11845763131, 44347.77826110849, 44529.332060018474, 10432.58269669235, 10524.210684198562, 10542.420166890895, 10584.259101862795, 10587.100096491884, 10601.41692206936, 10921.660814537163, 10984.793736075699, 11035.613753518588, 11128.054115400282, 9951.104400603981, 9996.750081247736, 10055.547500362354, 10230.386176829414, 10387.428691422045, 9452.763680908032, 9574.234061274941, 9598.0, 9607.423554586747, 9615.375000625218, 9784.657536986171, 10038.799224015625, 10044.447555384231, 10062.39625622465, 10066.44634545107, 8825.985011723735, 8862.77843053903, 8886.155815197546, 9015.0, 9124.0, 8689.956550217208, 8957.955210223907, 9080.40977336471, 9120.863187052068, 9401.10689484498], "value": 6052.797839114653, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 114.0, 116.0, 116.0, 115.0, 116.0, 114.0, 116.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 156.0, 177.0, 143.0, 166.0, 156.0, 136.0, 194.0, 133.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 178.0, 163.0, 163.0, 164.0, 163.0, 164.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 147.0, 77.0, 75.0, 75.0, 76.0, 162.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 149.0, 84.0, 85.0, 86.0, 140.0, 86.0, 85.0, 137.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 146.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 63.0, 65.0, 64.0, 66.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 84.0, 84.0, 86.0, 92.0, 86.0, 123.0, 87.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 137.0, 144.0, 143.0, 130.0, 143.0, 133.0, 136.0, 133.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 178.0, 174.0, 177.0, 170.0, 172.0, 175.0, 170.0, 171.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 68.0, 76.0, 67.0, 69.0, 66.0, 67.0, 66.0, 66.0], "value": 68.6, "unit": "score"}]}]} 18:35:11 INFO - Return code: 0 18:35:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:35:11 ERROR - # TBPL SUCCESS # 18:35:11 INFO - Running post-action listener: _resource_record_post_action 18:35:11 INFO - ##### 18:35:11 INFO - ##### Finished run-tests step (success) 18:35:11 INFO - ##### 18:35:11 INFO - Running post-run listener: _resource_record_post_run 18:35:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 534745088; Read time: 64; Write time: 488208 18:35:11 INFO - TinderboxPrint: CPU usage
13.4% 18:35:11 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 64 18:35:11 INFO - TinderboxPrint: I/O write bytes / time
534,745,088 / 488,208 18:35:11 INFO - TinderboxPrint: CPU idle
8,270.0 (86.6%) 18:35:11 INFO - TinderboxPrint: CPU user
1,226.9 (12.8%) 18:35:11 INFO - TinderboxPrint: Swap in / out
0 / 0 18:35:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237121536; Read time: 0; Write time: 292384 18:35:11 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 297623552; Read time: 64; Write time: 195824 18:35:12 INFO - Running post-run listener: _upload_blobber_files 18:35:12 INFO - Blob upload gear active. 18:35:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:35:12 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 18:35:12 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:35:12 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:35:12 INFO - (blobuploader) - INFO - Open directory for files ... 18:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:13 INFO - (blobuploader) - INFO - Done attempting. 18:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:14 INFO - (blobuploader) - INFO - Done attempting. 18:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:35:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:18 INFO - (blobuploader) - INFO - Done attempting. 18:35:18 INFO - (blobuploader) - INFO - Iteration through files over. 18:35:18 INFO - Return code: 0 18:35:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:35:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:35:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6520b7667f27304b9c02b2b78fb3928cb0403fba1f4d467e0b9f5143bc507972758d5774bcdedeff942ac2a174a32763902ecea2113eba28762518cee62a9c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87e9a349095e6f5e42885d55fd522478b5985f296410efdbbcca7f0efeaf05f2f525bb7955d372655ca5d2eeb7ed2744c9d7533f9d77624d88970afd3ce11fa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828ab09f297343b715b40ee415e713b6e325492b896260d53724af7065f0991fb9f78389a0835def56a74b4774dbb459a55aaccebfc24c25df4e7aee048ed6f5"} 18:35:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:35:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:35:18 INFO - Contents: 18:35:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6520b7667f27304b9c02b2b78fb3928cb0403fba1f4d467e0b9f5143bc507972758d5774bcdedeff942ac2a174a32763902ecea2113eba28762518cee62a9c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87e9a349095e6f5e42885d55fd522478b5985f296410efdbbcca7f0efeaf05f2f525bb7955d372655ca5d2eeb7ed2744c9d7533f9d77624d88970afd3ce11fa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828ab09f297343b715b40ee415e713b6e325492b896260d53724af7065f0991fb9f78389a0835def56a74b4774dbb459a55aaccebfc24c25df4e7aee048ed6f5"} 18:35:18 INFO - Running post-run listener: copy_logs_to_upload_dir 18:35:18 INFO - Copying logs to upload dir... 18:35:18 INFO - mkdir: /builds/slave/test/build/upload/logs 18:35:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.271914 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-31 18:35:18.145933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 18:35:18.150044) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543 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-Non-PGO/sha512/c6520b7667f27304b9c02b2b78fb3928cb0403fba1f4d467e0b9f5143bc507972758d5774bcdedeff942ac2a174a32763902ecea2113eba28762518cee62a9c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87e9a349095e6f5e42885d55fd522478b5985f296410efdbbcca7f0efeaf05f2f525bb7955d372655ca5d2eeb7ed2744c9d7533f9d77624d88970afd3ce11fa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828ab09f297343b715b40ee415e713b6e325492b896260d53724af7065f0991fb9f78389a0835def56a74b4774dbb459a55aaccebfc24c25df4e7aee048ed6f5"} build_url:https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/BkgntuUnQ5GSKTZhwUcU8w/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-Non-PGO/sha512/c6520b7667f27304b9c02b2b78fb3928cb0403fba1f4d467e0b9f5143bc507972758d5774bcdedeff942ac2a174a32763902ecea2113eba28762518cee62a9c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87e9a349095e6f5e42885d55fd522478b5985f296410efdbbcca7f0efeaf05f2f525bb7955d372655ca5d2eeb7ed2744c9d7533f9d77624d88970afd3ce11fa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/828ab09f297343b715b40ee415e713b6e325492b896260d53724af7065f0991fb9f78389a0835def56a74b4774dbb459a55aaccebfc24c25df4e7aee048ed6f5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 18:35:18.175848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:35:18.176230) ========= 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=c6927cf182745ad25b1d38b9000001fe-1464743394.156147-1995649543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 18:35:18.261568) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 18:35:18.261947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 18:35:18.262289) ========= ========= Total master_lag: 0.20 =========